builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1477359685.08 results: success (0) buildid: 20161024183303 builduid: 6fd76b22c5ec434ea9eb442649fffaf4 revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.076808) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.077350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.077643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.092879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.093293) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 18:41:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-24 18:41:25 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.228302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.228706) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.278620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.279037) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6571211c807e209e550833eb47dfc08a4c6ae53 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 18:41:25,499 truncating revision to first 12 chars 2016-10-24 18:41:25,499 Setting DEBUG logging. 2016-10-24 18:41:25,499 attempt 1/10 2016-10-24 18:41:25,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6571211c807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 18:41:25,810 unpacking tar archive at: fx-team-b6571211c807/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.919588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.919922) ========= script_repo_revision: b6571211c807e209e550833eb47dfc08a4c6ae53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.920328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.920601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 18:41:25.930949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-24 18:41:25.931383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:41:26 INFO - MultiFileLogger online at 20161024 18:41:26 in /builds/slave/test 18:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:41:26 INFO - {'append_to_log': False, 18:41:26 INFO - 'base_work_dir': '/builds/slave/test', 18:41:26 INFO - 'blob_upload_branch': 'Fx-Team', 18:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:41:26 INFO - 'branch': 'Fx-Team', 18:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:41:26 INFO - 'config_files': ('talos/linux_config.py',), 18:41:26 INFO - 'default_actions': ('clobber', 18:41:26 INFO - 'read-buildbot-config', 18:41:26 INFO - 'download-and-extract', 18:41:26 INFO - 'populate-webroot', 18:41:26 INFO - 'create-virtualenv', 18:41:26 INFO - 'install', 18:41:26 INFO - 'run-tests'), 18:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:41:26 INFO - 'download_minidump_stackwalk': True, 18:41:26 INFO - 'download_symbols': 'ondemand', 18:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:41:26 INFO - 'installer_path': 'installer.exe', 18:41:26 INFO - 'log_level': 'info', 18:41:26 INFO - 'log_name': 'talos', 18:41:26 INFO - 'log_to_console': True, 18:41:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:41:26 INFO - 'opt_config_files': (), 18:41:26 INFO - 'pip_index': False, 18:41:26 INFO - 'sps_profile': False, 18:41:26 INFO - 'sps_profile_interval': 0, 18:41:26 INFO - 'suite': 'dromaeojs', 18:41:26 INFO - 'system_bits': '32', 18:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:41:26 INFO - 'title': 'talos-linux64-ix-021', 18:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:41:26 INFO - 'use_talos_json': True, 18:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:41:26 INFO - 'work_dir': 'build'} 18:41:26 INFO - [mozharness: 2016-10-25 01:41:26.258746Z] Running clobber step. 18:41:26 INFO - Running pre-action listener: _resource_record_pre_action 18:41:26 INFO - Running main action method: clobber 18:41:26 INFO - rmtree: /builds/slave/test/build 18:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:41:27 INFO - Running post-action listener: _resource_record_post_action 18:41:27 INFO - [mozharness: 2016-10-25 01:41:27.326915Z] Finished clobber step (success) 18:41:27 INFO - [mozharness: 2016-10-25 01:41:27.327015Z] Running read-buildbot-config step. 18:41:27 INFO - Running pre-action listener: _resource_record_pre_action 18:41:27 INFO - Running main action method: read_buildbot_config 18:41:27 INFO - Using buildbot properties: 18:41:27 INFO - { 18:41:27 INFO - "project": "", 18:41:27 INFO - "product": "firefox", 18:41:27 INFO - "script_repo_revision": "production", 18:41:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:41:27 INFO - "repository": "", 18:41:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:41:27 INFO - "buildid": "20161024183303", 18:41:27 INFO - "stage_platform": "linux64-pgo", 18:41:27 INFO - "basedir": "/builds/slave/test", 18:41:27 INFO - "buildnumber": 556, 18:41:27 INFO - "platform": "ubuntu64_hw", 18:41:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:41:27 INFO - "slavebuilddir": "test", 18:41:27 INFO - "branch": "fx-team", 18:41:27 INFO - "revision": "b6571211c807e209e550833eb47dfc08a4c6ae53", 18:41:27 INFO - "slavename": "talos-linux64-ix-021", 18:41:27 INFO - "builduid": "6fd76b22c5ec434ea9eb442649fffaf4", 18:41:27 INFO - "repo_path": "integration/fx-team" 18:41:27 INFO - } 18:41:27 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:41:27 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:41:27 INFO - Running post-action listener: _resource_record_post_action 18:41:27 INFO - [mozharness: 2016-10-25 01:41:27.329398Z] Finished read-buildbot-config step (success) 18:41:27 INFO - [mozharness: 2016-10-25 01:41:27.329487Z] Running download-and-extract step. 18:41:27 INFO - Running pre-action listener: _resource_record_pre_action 18:41:27 INFO - Running main action method: download_and_extract 18:41:27 INFO - mkdir: /builds/slave/test/build/tests 18:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:41:27 INFO - Downloaded 1361 bytes. 18:41:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:41:27 INFO - Using the following test package requirements: 18:41:27 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:41:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:41:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'jsshell-linux-x86_64.zip'], 18:41:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:41:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:41:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:41:27 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:41:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:41:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:41:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:41:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:41:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:41:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:41:27 INFO - Http code: 200 18:41:27 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 18:41:27 INFO - x-amz-cf-id: g3Ews172NHo9Q5w_OA-GERtACVqsABVOYqFhT0ALoiJjWmIxnsw1BQ== 18:41:27 INFO - x-amz-replication-status: COMPLETED 18:41:27 INFO - x-amz-version-id: Ud.qfa84lm6eQ5BSOKfORghQ0SOoE81B 18:41:28 INFO - Expected file size: 22021843 18:41:28 INFO - Obtained file size: 22021843 18:41:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:41:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:41:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:32 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:41:32 INFO - Http code: 200 18:41:32 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 18:41:32 INFO - x-amz-cf-id: ApATI0UOcuDRfYM25Nd9NKrMIVK8VUK6dKnjxAm0OBQTBoNj5G_l2g== 18:41:32 INFO - x-amz-replication-status: COMPLETED 18:41:32 INFO - x-amz-version-id: Ud.qfa84lm6eQ5BSOKfORghQ0SOoE81B 18:41:32 INFO - Expected file size: 22021843 18:41:32 INFO - Obtained file size: 22021843 18:41:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:41:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:41:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:41:37 INFO - Http code: 200 18:41:37 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 18:41:37 INFO - x-amz-cf-id: s-zgkH4OgS64x6B7QCFo7yW1huGF4rD-PYk4Jjv4E4A6_vLlY1L76w== 18:41:37 INFO - x-amz-replication-status: COMPLETED 18:41:37 INFO - x-amz-version-id: oenI_sZRW87EdrewdmEEIPc75eIJqG54 18:41:37 INFO - Expected file size: 14409028 18:41:37 INFO - Obtained file size: 14409028 18:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:38 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:38 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:41:38 INFO - Downloaded 59396065 bytes. 18:41:38 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:38 INFO - mkdir: /builds/slave/test/properties 18:41:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:41:38 INFO - Writing to file /builds/slave/test/properties/build_url 18:41:38 INFO - Contents: 18:41:38 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:39 INFO - Running post-action listener: _resource_record_post_action 18:41:39 INFO - Running post-action listener: set_extra_try_arguments 18:41:39 INFO - [mozharness: 2016-10-25 01:41:39.100597Z] Finished download-and-extract step (success) 18:41:39 INFO - [mozharness: 2016-10-25 01:41:39.100824Z] Running populate-webroot step. 18:41:39 INFO - Running pre-action listener: _resource_record_pre_action 18:41:39 INFO - Running main action method: populate_webroot 18:41:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:41:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:41:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:41:39 INFO - '--tppagecycles', 18:41:39 INFO - '7'], 18:41:39 INFO - 'tests': ['tsvgm']}}, 18:41:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:41:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:41:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:41:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:41:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['damp', 'tps']}, 18:41:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'tests': ['damp', 'tps']}, 18:41:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['dromaeo_dom']}, 18:41:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['basic_compositor_video']}, 18:41:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:41:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'other-e10s': {'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['a11yr', 18:41:39 INFO - 'ts_paint', 18:41:39 INFO - 'tpaint', 18:41:39 INFO - 'sessionrestore', 18:41:39 INFO - 'sessionrestore_no_auto_restore', 18:41:39 INFO - 'tabpaint']}, 18:41:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['tsvgx', 18:41:39 INFO - 'tsvgr_opacity', 18:41:39 INFO - 'tart', 18:41:39 INFO - 'tscrollx', 18:41:39 INFO - 'cart']}, 18:41:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:41:39 INFO - 'tsvgr_opacity', 18:41:39 INFO - 'tart', 18:41:39 INFO - 'tscrollx', 18:41:39 INFO - 'cart']}, 18:41:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'talos_options': ['--disable-e10s'], 18:41:39 INFO - 'tests': ['tp5o']}, 18:41:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'tests': ['tp5o']}, 18:41:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'talos_options': ['--disable-e10s', 18:41:39 INFO - '--xperf_path', 18:41:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:39 INFO - 'tests': ['tp5n']}, 18:41:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:39 INFO - 'talos_options': ['--xperf_path', 18:41:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:39 INFO - 'tests': ['tp5n']}}, 18:41:39 INFO - 'talos.zip': {'path': '', 18:41:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:39 INFO - Running post-action listener: _resource_record_post_action 18:41:39 INFO - [mozharness: 2016-10-25 01:41:39.118408Z] Finished populate-webroot step (success) 18:41:39 INFO - [mozharness: 2016-10-25 01:41:39.118496Z] Running create-virtualenv step. 18:41:39 INFO - Running pre-action listener: _resource_record_pre_action 18:41:39 INFO - Running main action method: create_virtualenv 18:41:39 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:41:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:41:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:39 INFO - Using real prefix '/usr' 18:41:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:41 INFO - Installing pip.................done. 18:41:41 INFO - Return code: 0 18:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:41:41 INFO - Reading from file tmpfile_stdout 18:41:41 INFO - Output received: 18:41:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:41:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:41:41 INFO - Using env: {'DISPLAY': ':0', 18:41:41 INFO - 'HOME': '/home/cltbld', 18:41:41 INFO - 'LANG': 'en_US.UTF-8', 18:41:41 INFO - 'LANGUAGE': 'en_US:en', 18:41:41 INFO - 'LOGNAME': 'cltbld', 18:41:41 INFO - 'MAIL': '/var/mail/cltbld', 18:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:41 INFO - 'MOZ_NO_REMOTE': '1', 18:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:41 INFO - 'NO_EM_RESTART': '1', 18:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:41 INFO - 'PWD': '/builds/slave/test', 18:41:41 INFO - 'SHELL': '/bin/bash', 18:41:41 INFO - 'SHLVL': '1', 18:41:41 INFO - 'TERM': 'linux', 18:41:41 INFO - 'TMOUT': '86400', 18:41:41 INFO - 'USER': 'cltbld', 18:41:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:41 INFO - '_': '/tools/buildbot/bin/python'} 18:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:41:42 INFO - Cleaning up... 18:41:42 INFO - Return code: 0 18:41:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:41:42 INFO - Using env: {'DISPLAY': ':0', 18:41:42 INFO - 'HOME': '/home/cltbld', 18:41:42 INFO - 'LANG': 'en_US.UTF-8', 18:41:42 INFO - 'LANGUAGE': 'en_US:en', 18:41:42 INFO - 'LOGNAME': 'cltbld', 18:41:42 INFO - 'MAIL': '/var/mail/cltbld', 18:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:42 INFO - 'MOZ_NO_REMOTE': '1', 18:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:42 INFO - 'NO_EM_RESTART': '1', 18:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:42 INFO - 'PWD': '/builds/slave/test', 18:41:42 INFO - 'SHELL': '/bin/bash', 18:41:42 INFO - 'SHLVL': '1', 18:41:42 INFO - 'TERM': 'linux', 18:41:42 INFO - 'TMOUT': '86400', 18:41:42 INFO - 'USER': 'cltbld', 18:41:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:42 INFO - '_': '/tools/buildbot/bin/python'} 18:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:42 INFO - Downloading/unpacking psutil>=3.1.1 18:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:44 INFO - Installing collected packages: psutil 18:41:44 INFO - Running setup.py install for psutil 18:41:44 INFO - building 'psutil._psutil_linux' extension 18:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:41:44 INFO - building 'psutil._psutil_posix' extension 18:41:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:41:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:41:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:44 INFO - Successfully installed psutil 18:41:44 INFO - Cleaning up... 18:41:45 INFO - Return code: 0 18:41:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:41:45 INFO - Using env: {'DISPLAY': ':0', 18:41:45 INFO - 'HOME': '/home/cltbld', 18:41:45 INFO - 'LANG': 'en_US.UTF-8', 18:41:45 INFO - 'LANGUAGE': 'en_US:en', 18:41:45 INFO - 'LOGNAME': 'cltbld', 18:41:45 INFO - 'MAIL': '/var/mail/cltbld', 18:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:45 INFO - 'MOZ_NO_REMOTE': '1', 18:41:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:45 INFO - 'NO_EM_RESTART': '1', 18:41:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:45 INFO - 'PWD': '/builds/slave/test', 18:41:45 INFO - 'SHELL': '/bin/bash', 18:41:45 INFO - 'SHLVL': '1', 18:41:45 INFO - 'TERM': 'linux', 18:41:45 INFO - 'TMOUT': '86400', 18:41:45 INFO - 'USER': 'cltbld', 18:41:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:45 INFO - '_': '/tools/buildbot/bin/python'} 18:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:41:47 INFO - Installing collected packages: mozsystemmonitor 18:41:47 INFO - Running setup.py install for mozsystemmonitor 18:41:47 INFO - Successfully installed mozsystemmonitor 18:41:47 INFO - Cleaning up... 18:41:47 INFO - Return code: 0 18:41:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:41:47 INFO - Using env: {'DISPLAY': ':0', 18:41:47 INFO - 'HOME': '/home/cltbld', 18:41:47 INFO - 'LANG': 'en_US.UTF-8', 18:41:47 INFO - 'LANGUAGE': 'en_US:en', 18:41:47 INFO - 'LOGNAME': 'cltbld', 18:41:47 INFO - 'MAIL': '/var/mail/cltbld', 18:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:47 INFO - 'MOZ_NO_REMOTE': '1', 18:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:47 INFO - 'NO_EM_RESTART': '1', 18:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:47 INFO - 'PWD': '/builds/slave/test', 18:41:47 INFO - 'SHELL': '/bin/bash', 18:41:47 INFO - 'SHLVL': '1', 18:41:47 INFO - 'TERM': 'linux', 18:41:47 INFO - 'TMOUT': '86400', 18:41:47 INFO - 'USER': 'cltbld', 18:41:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:47 INFO - '_': '/tools/buildbot/bin/python'} 18:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:47 INFO - Downloading/unpacking jsonschema==2.5.1 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:49 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:49 INFO - warning: no files found matching '*.txt' 18:41:49 INFO - no previously-included directories found matching 'build' 18:41:49 INFO - no previously-included directories found matching 'dist' 18:41:49 INFO - no previously-included directories found matching '.git*' 18:41:49 INFO - Installing collected packages: jsonschema, functools32 18:41:49 INFO - Running setup.py install for functools32 18:41:49 INFO - warning: no files found matching '*.txt' 18:41:49 INFO - no previously-included directories found matching 'build' 18:41:49 INFO - no previously-included directories found matching 'dist' 18:41:49 INFO - no previously-included directories found matching '.git*' 18:41:49 INFO - Successfully installed jsonschema functools32 18:41:49 INFO - Cleaning up... 18:41:50 INFO - Return code: 0 18:41:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:41:50 INFO - Using env: {'DISPLAY': ':0', 18:41:50 INFO - 'HOME': '/home/cltbld', 18:41:50 INFO - 'LANG': 'en_US.UTF-8', 18:41:50 INFO - 'LANGUAGE': 'en_US:en', 18:41:50 INFO - 'LOGNAME': 'cltbld', 18:41:50 INFO - 'MAIL': '/var/mail/cltbld', 18:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:50 INFO - 'MOZ_NO_REMOTE': '1', 18:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:50 INFO - 'NO_EM_RESTART': '1', 18:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:50 INFO - 'PWD': '/builds/slave/test', 18:41:50 INFO - 'SHELL': '/bin/bash', 18:41:50 INFO - 'SHLVL': '1', 18:41:50 INFO - 'TERM': 'linux', 18:41:50 INFO - 'TMOUT': '86400', 18:41:50 INFO - 'USER': 'cltbld', 18:41:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:50 INFO - '_': '/tools/buildbot/bin/python'} 18:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:41:50 INFO - Cleaning up... 18:41:50 INFO - Return code: 0 18:41:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:41:50 INFO - Using env: {'DISPLAY': ':0', 18:41:50 INFO - 'HOME': '/home/cltbld', 18:41:50 INFO - 'LANG': 'en_US.UTF-8', 18:41:50 INFO - 'LANGUAGE': 'en_US:en', 18:41:50 INFO - 'LOGNAME': 'cltbld', 18:41:50 INFO - 'MAIL': '/var/mail/cltbld', 18:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:50 INFO - 'MOZ_NO_REMOTE': '1', 18:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:50 INFO - 'NO_EM_RESTART': '1', 18:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:50 INFO - 'PWD': '/builds/slave/test', 18:41:50 INFO - 'SHELL': '/bin/bash', 18:41:50 INFO - 'SHLVL': '1', 18:41:50 INFO - 'TERM': 'linux', 18:41:50 INFO - 'TMOUT': '86400', 18:41:50 INFO - 'USER': 'cltbld', 18:41:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:50 INFO - '_': '/tools/buildbot/bin/python'} 18:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:53 INFO - Downloading docopt-0.6.1.tar.gz 18:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:53 INFO - Running setup.py install for blobuploader 18:41:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:53 INFO - Running setup.py install for requests 18:41:53 INFO - Running setup.py install for docopt 18:41:53 INFO - Successfully installed blobuploader requests docopt 18:41:53 INFO - Cleaning up... 18:41:53 INFO - Return code: 0 18:41:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:53 INFO - Using env: {'DISPLAY': ':0', 18:41:53 INFO - 'HOME': '/home/cltbld', 18:41:53 INFO - 'LANG': 'en_US.UTF-8', 18:41:53 INFO - 'LANGUAGE': 'en_US:en', 18:41:53 INFO - 'LOGNAME': 'cltbld', 18:41:53 INFO - 'MAIL': '/var/mail/cltbld', 18:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:53 INFO - 'MOZ_NO_REMOTE': '1', 18:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:53 INFO - 'NO_EM_RESTART': '1', 18:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:53 INFO - 'PWD': '/builds/slave/test', 18:41:53 INFO - 'SHELL': '/bin/bash', 18:41:53 INFO - 'SHLVL': '1', 18:41:53 INFO - 'TERM': 'linux', 18:41:53 INFO - 'TMOUT': '86400', 18:41:53 INFO - 'USER': 'cltbld', 18:41:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:53 INFO - '_': '/tools/buildbot/bin/python'} 18:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:53 INFO - Running setup.py (path:/tmp/pip-NDS_nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:54 INFO - Running setup.py (path:/tmp/pip-RPL9xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:54 INFO - Running setup.py (path:/tmp/pip-Etid1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:54 INFO - Running setup.py (path:/tmp/pip-hdIRh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:54 INFO - Running setup.py (path:/tmp/pip-73ojkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:54 INFO - Running setup.py (path:/tmp/pip-kHkhp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:54 INFO - Running setup.py (path:/tmp/pip-rwOFBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:54 INFO - Running setup.py (path:/tmp/pip-XKzJPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:54 INFO - Running setup.py (path:/tmp/pip-c40ehN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:54 INFO - Running setup.py (path:/tmp/pip-I_pRwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:54 INFO - Running setup.py (path:/tmp/pip-IXCAFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:54 INFO - Running setup.py (path:/tmp/pip-TV6fzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:54 INFO - Running setup.py (path:/tmp/pip-NPHR1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:54 INFO - Running setup.py (path:/tmp/pip-US1pPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:54 INFO - Running setup.py (path:/tmp/pip-vuIH_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:55 INFO - Running setup.py (path:/tmp/pip-EM00wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:55 INFO - Running setup.py (path:/tmp/pip-HrjVdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:55 INFO - Running setup.py install for manifestparser 18:41:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:55 INFO - Running setup.py install for mozcrash 18:41:55 INFO - Running setup.py install for mozdebug 18:41:55 INFO - Running setup.py install for mozdevice 18:41:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:55 INFO - Running setup.py install for mozfile 18:41:55 INFO - Running setup.py install for mozhttpd 18:41:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:55 INFO - Running setup.py install for mozinfo 18:41:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:55 INFO - Running setup.py install for mozInstall 18:41:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Running setup.py install for mozleak 18:41:56 INFO - Running setup.py install for mozlog 18:41:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Running setup.py install for moznetwork 18:41:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Running setup.py install for mozprocess 18:41:56 INFO - Running setup.py install for mozprofile 18:41:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Running setup.py install for mozrunner 18:41:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Running setup.py install for mozscreenshot 18:41:56 INFO - Running setup.py install for moztest 18:41:56 INFO - Running setup.py install for mozversion 18:41:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:56 INFO - Cleaning up... 18:41:57 INFO - Return code: 0 18:41:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:41:57 INFO - Using env: {'DISPLAY': ':0', 18:41:57 INFO - 'HOME': '/home/cltbld', 18:41:57 INFO - 'LANG': 'en_US.UTF-8', 18:41:57 INFO - 'LANGUAGE': 'en_US:en', 18:41:57 INFO - 'LOGNAME': 'cltbld', 18:41:57 INFO - 'MAIL': '/var/mail/cltbld', 18:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:57 INFO - 'MOZ_NO_REMOTE': '1', 18:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:57 INFO - 'NO_EM_RESTART': '1', 18:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:57 INFO - 'PWD': '/builds/slave/test', 18:41:57 INFO - 'SHELL': '/bin/bash', 18:41:57 INFO - 'SHLVL': '1', 18:41:57 INFO - 'TERM': 'linux', 18:41:57 INFO - 'TMOUT': '86400', 18:41:57 INFO - 'USER': 'cltbld', 18:41:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:57 INFO - '_': '/tools/buildbot/bin/python'} 18:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:57 INFO - Running setup.py (path:/tmp/pip-5rMGJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:57 INFO - Running setup.py (path:/tmp/pip-ejCKU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:57 INFO - Running setup.py (path:/tmp/pip-mtKW33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:57 INFO - Running setup.py (path:/tmp/pip-olQaFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:57 INFO - Running setup.py (path:/tmp/pip-SkDdiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:57 INFO - Running setup.py (path:/tmp/pip-wv1yvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:57 INFO - Running setup.py (path:/tmp/pip-oG9JEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:57 INFO - Running setup.py (path:/tmp/pip-ortpJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:57 INFO - Running setup.py (path:/tmp/pip-XwOun_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:57 INFO - Running setup.py (path:/tmp/pip-KL_mAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:57 INFO - Running setup.py (path:/tmp/pip-Gk1l65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:58 INFO - Running setup.py (path:/tmp/pip-tv20xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:58 INFO - Running setup.py (path:/tmp/pip-3EWq4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:58 INFO - Running setup.py (path:/tmp/pip-Ez63RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:58 INFO - Running setup.py (path:/tmp/pip-m2v2bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:58 INFO - Running setup.py (path:/tmp/pip-98SHt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:58 INFO - Running setup.py (path:/tmp/pip-2l7l0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:00 INFO - Downloading blessings-1.6.tar.gz 18:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:42:00 INFO - Installing collected packages: blessings 18:42:00 INFO - Running setup.py install for blessings 18:42:00 INFO - Successfully installed blessings 18:42:00 INFO - Cleaning up... 18:42:00 INFO - Return code: 0 18:42:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:00 INFO - Reading from file tmpfile_stdout 18:42:00 INFO - Current package versions: 18:42:00 INFO - argparse == 1.2.1 18:42:00 INFO - blessings == 1.6 18:42:00 INFO - blobuploader == 1.2.4 18:42:00 INFO - docopt == 0.6.1 18:42:00 INFO - functools32 == 3.2.3-2 18:42:00 INFO - jsonschema == 2.5.1 18:42:00 INFO - manifestparser == 1.1 18:42:00 INFO - mozInstall == 1.12 18:42:00 INFO - mozcrash == 0.17 18:42:00 INFO - mozdebug == 0.1 18:42:00 INFO - mozdevice == 0.48 18:42:00 INFO - mozfile == 1.2 18:42:00 INFO - mozhttpd == 0.7 18:42:00 INFO - mozinfo == 0.9 18:42:00 INFO - mozleak == 0.1 18:42:00 INFO - mozlog == 3.4 18:42:00 INFO - moznetwork == 0.27 18:42:00 INFO - mozprocess == 0.23 18:42:00 INFO - mozprofile == 0.28 18:42:00 INFO - mozrunner == 6.12 18:42:00 INFO - mozscreenshot == 0.1 18:42:00 INFO - mozsystemmonitor == 0.3 18:42:00 INFO - moztest == 0.7 18:42:00 INFO - mozversion == 1.4 18:42:00 INFO - psutil == 3.1.1 18:42:00 INFO - requests == 1.2.3 18:42:00 INFO - wsgiref == 0.1.2 18:42:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:42:00 INFO - Using env: {'DISPLAY': ':0', 18:42:00 INFO - 'HOME': '/home/cltbld', 18:42:00 INFO - 'LANG': 'en_US.UTF-8', 18:42:00 INFO - 'LANGUAGE': 'en_US:en', 18:42:00 INFO - 'LOGNAME': 'cltbld', 18:42:00 INFO - 'MAIL': '/var/mail/cltbld', 18:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:00 INFO - 'MOZ_NO_REMOTE': '1', 18:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:00 INFO - 'NO_EM_RESTART': '1', 18:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:00 INFO - 'PWD': '/builds/slave/test', 18:42:00 INFO - 'SHELL': '/bin/bash', 18:42:00 INFO - 'SHLVL': '1', 18:42:00 INFO - 'TERM': 'linux', 18:42:00 INFO - 'TMOUT': '86400', 18:42:00 INFO - 'USER': 'cltbld', 18:42:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:00 INFO - '_': '/tools/buildbot/bin/python'} 18:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:42:01 INFO - Cleaning up... 18:42:01 INFO - Return code: 0 18:42:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f417fe52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:42:01 INFO - Using env: {'DISPLAY': ':0', 18:42:01 INFO - 'HOME': '/home/cltbld', 18:42:01 INFO - 'LANG': 'en_US.UTF-8', 18:42:01 INFO - 'LANGUAGE': 'en_US:en', 18:42:01 INFO - 'LOGNAME': 'cltbld', 18:42:01 INFO - 'MAIL': '/var/mail/cltbld', 18:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:01 INFO - 'MOZ_NO_REMOTE': '1', 18:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:01 INFO - 'NO_EM_RESTART': '1', 18:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:01 INFO - 'PWD': '/builds/slave/test', 18:42:01 INFO - 'SHELL': '/bin/bash', 18:42:01 INFO - 'SHLVL': '1', 18:42:01 INFO - 'TERM': 'linux', 18:42:01 INFO - 'TMOUT': '86400', 18:42:01 INFO - 'USER': 'cltbld', 18:42:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:01 INFO - '_': '/tools/buildbot/bin/python'} 18:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:42:01 INFO - Cleaning up... 18:42:01 INFO - Return code: 0 18:42:01 INFO - Running post-action listener: _resource_record_post_action 18:42:01 INFO - Running post-action listener: _start_resource_monitoring 18:42:01 INFO - Starting resource monitoring. 18:42:01 INFO - [mozharness: 2016-10-25 01:42:01.358616Z] Finished create-virtualenv step (success) 18:42:01 INFO - [mozharness: 2016-10-25 01:42:01.359080Z] Running install step. 18:42:01 INFO - Running pre-action listener: _resource_record_pre_action 18:42:01 INFO - Running main action method: install 18:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:42:01 INFO - Reading from file tmpfile_stdout 18:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:42:01 INFO - Reading from file tmpfile_stdout 18:42:01 INFO - Output received: 18:42:01 INFO - Usage: mozinstall [options] installer 18:42:01 INFO - Options: 18:42:01 INFO - -h, --help show this help message and exit 18:42:01 INFO - -d DEST, --destination=DEST 18:42:01 INFO - Directory to install application into. [default: 18:42:01 INFO - "/builds/slave/test"] 18:42:01 INFO - --app=APP Application being installed. [default: firefox] 18:42:01 INFO - mkdir: /builds/slave/test/build/application 18:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:42:18 INFO - Reading from file tmpfile_stdout 18:42:18 INFO - Output received: 18:42:18 INFO - /builds/slave/test/build/application/firefox/firefox 18:42:18 INFO - Running post-action listener: _resource_record_post_action 18:42:18 INFO - [mozharness: 2016-10-25 01:42:18.581164Z] Finished install step (success) 18:42:18 INFO - [mozharness: 2016-10-25 01:42:18.581434Z] Running run-tests step. 18:42:18 INFO - Running pre-action listener: _resource_record_pre_action 18:42:18 INFO - Running main action method: run_tests 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:18 INFO - Python 2.7.3 18:42:18 INFO - Return code: 0 18:42:18 INFO - grabbing minidump binary from tooltool 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2167790>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2168690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2168b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:42:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:42:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:42:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:18 INFO - Return code: 0 18:42:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:42:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:42:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:42:18 INFO - Using env: {'DISPLAY': ':0', 18:42:18 INFO - 'HOME': '/home/cltbld', 18:42:18 INFO - 'LANG': 'en_US.UTF-8', 18:42:18 INFO - 'LANGUAGE': 'en_US:en', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MAIL': '/var/mail/cltbld', 18:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SHLVL': '1', 18:42:18 INFO - 'TERM': 'linux', 18:42:18 INFO - 'TMOUT': '86400', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1477359684.589534-218725927', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - '_': '/tools/buildbot/bin/python'} 18:42:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:42:18 INFO - mozversion application_buildid: 20161024153034 18:42:18 INFO - mozversion application_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:42:18 INFO - mozversion application_display_name: Nightly 18:42:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:18 INFO - mozversion application_name: Firefox 18:42:18 INFO - mozversion application_remotingname: firefox 18:42:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:42:18 INFO - mozversion application_vendor: Mozilla 18:42:18 INFO - mozversion application_version: 52.0a1 18:42:18 INFO - mozversion platform_buildid: 20161024153034 18:42:18 INFO - mozversion platform_changeset: b6571211c807e209e550833eb47dfc08a4c6ae53 18:42:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:42:18 INFO - mozversion platform_version: 52.0a1 18:42:18 INFO - using testdate: 1477359738 18:42:18 INFO - actual date: 1477359738 18:42:18 INFO - starting webserver on 'localhost:49151' 18:42:18 INFO - SUITE-START | Running 2 tests 18:42:18 INFO - TEST-START | dromaeo_css 18:42:18 INFO - operating with platform_type : linux_ 18:42:18 INFO - Initialising browser for dromaeo_css test... 18:42:18 INFO - TEST-INFO | started process 4831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPcA0v/profile http://localhost:49151/getInfo.html) 18:42:22 INFO - PROCESS | 4831 | __metrics Screen width/height:1600/1200 18:42:22 INFO - PROCESS | 4831 | colorDepth:24 18:42:22 INFO - PROCESS | 4831 | Browser inner width/height: 1024/697 18:42:22 INFO - PROCESS | 4831 | __metrics 18:42:23 INFO - PROCESS | 4831 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:42:23 INFO - PROCESS | 4831 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:24 INFO - PROCESS | 4831 | console.error: PushService: 18:42:24 INFO - PROCESS | 4831 | stateChangeProcessEnqueue: Error transitioning state 18:42:24 INFO - PROCESS | 4831 | UnknownError 18:42:25 INFO - TEST-INFO | 4831: exit 0 18:42:25 INFO - Browser initialized. 18:42:25 INFO - Running cycle 1/1 for dromaeo_css test... 18:42:25 INFO - TEST-INFO | started process 4912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPcA0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:37 INFO - PROCESS | 4912 | RSS: Main: 171941888 18:42:37 INFO - PROCESS | 4912 | 18:43:29 INFO - PROCESS | 4912 | 1477359809247 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:45:39 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49151/tests/dromaeo/cssquery-ext.html) 18:45:41 INFO - PROCESS | 4912 | RSS: Main: 289103872 18:45:41 INFO - PROCESS | 4912 | 18:48:44 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-ext.html (next: http://localhost:49151/tests/dromaeo/cssquery-jquery.html) 18:48:45 INFO - PROCESS | 4912 | RSS: Main: 284553216 18:48:45 INFO - PROCESS | 4912 | 18:51:47 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49151/tests/dromaeo/cssquery-mootools.html) 18:51:47 INFO - PROCESS | 4912 | RSS: Main: 220905472 18:51:47 INFO - PROCESS | 4912 | 18:54:49 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49151/tests/dromaeo/cssquery-prototype.html) 18:54:50 INFO - PROCESS | 4912 | RSS: Main: 246702080 18:54:50 INFO - PROCESS | 4912 | 18:57:53 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49151/tests/dromaeo/cssquery-yui.html) 18:57:53 INFO - PROCESS | 4912 | RSS: Main: 220753920 18:57:53 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | Cycle 1(1): loaded http://localhost:49151/tests/dromaeo/cssquery-yui.html (next: http://localhost:49151/tests/dromaeo/cssquery-dojo.html) 19:00:57 INFO - PROCESS | 4912 | RSS: Main: 318574592 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | __start_tp_report 19:00:57 INFO - PROCESS | 4912 | _x_x_mozilla_page_load 19:00:57 INFO - PROCESS | 4912 | _x_x_mozilla_page_load_details 19:00:57 INFO - PROCESS | 4912 | |i|pagename|runs| 19:00:57 INFO - PROCESS | 4912 | |0;dojo.html;3060.066679662703;3077.9538306925388;3114.8131112133265;3126.6873312668736;3128.3117714102905;5261.158214685651;5370.516653501184;5381.973090134548;5458.208559758833;5468.863278418036;5378.112611419121;5416.702081385522;5445.945540544593;5468.043092458824;5480.945190548094;4892.315075889378;4893.951060489403;4940.357753492059;4947.084789313971;4973.204287314031;4907.190313598252;5006.374203224597;5023.422306434752;5029.698218106907;5094.1085310070775;4817.807287708522;4854.393200849894;4969.826056088055;5023.799048038074;5041.747912604355;4879.82920597781;4910.091633047898;4914.3611330527165;4957.752112394366;4988.5260900214425;4865.927011094836;4903.779329930162;4909.901801963941;4957.479464656231;4970;5417.241586177938;5418.972905135449;5420.485053919911;5430.51125398716;5491.176323551459;5644.3508996465525;5652.604317697763;5697.0599851024535;5777.480026797566;5780.3063632363965;5745.971270143623;5836.5914385993;5851.824445266649;5853.29760428747;5855.209546711182;5339.439358867341;5351.518363347279;5356.303680521507;5358.892822143535;5359.490848369438;5808.5353171747;5811.215485909433;5867.413258674099;5873.295204575393;5875.383084776123;5587.8603034923635;5591.496765291144;5629.915551266734;5637.210790489335;5648.604597678123;5678.772849086073;5683.2895888014;5684.8294551163535;5685.886282274331;5750.418634875359;5775.971120144372;5779.942200577941;5783.103618939072;5783.450572195635;5787.479126878601;5580.693061881636;5691;5691.544676425876;5707.971460142756;5862.677552734641;4381.145676593097;4403.383526306319;4404.207242696281;4417;4456.264716321835;3917.4319723639915;3934.075492259317;3936.291467535814;3970.741901776433;3976.681865450757;5328.120860058125;5359.330083739533;5454.53636440899;5484.862878427992;5490.862728431821;5865.912011319833;5866.032104702762;5867.530597552186;5883.823485295448;5911.024680927685;5510.201020851954;5516.834494965157;5517.337919449692;5518.91721624176;5519.172124181325;4936.975315123474;4978.427480839678;5044.394672639307;5050.065737838511;5118.078745825787;6050.273967123973;6096.88955463735;6101.459346768484;6105.732692890381;6107.46191531438;5890.528757699288;5892.852678683067;5895.233619629421;5901.704914754159;5942.762289508371;5853.239078919713;5899.262592175978;5962.5528085394635;6038.456538911519;6049.546284028627;5646.830595082154;5669.177969194361;5671.773129074791;5683.033884239772;5685.687287199244;5749.856253593526;5751.683657398883;5752.626079304831;5754.021816291157;5760.884782304247;5652.039153343859;5656.60403771732;5657.60396772222;5657.717114144359;5659.377468478547;5603.047481928001;5649.774009039593;5656.377798442086;5657.8019769307875;5659.377468478382;5634.380218175916;5640.54875609942;5664.178694089416;5667.943320566907;5668.858278543069;5563.666180029211;5607.102863541813;5709.429057094258;5719.542436604978;5721;5427.077396842626;5501.944980550304;5516.972415137899;5529.889402212014;5534.252875861707 19:00:57 INFO - PROCESS | 4912 | |1;ext.html;597.4025974025973;619.9535034872385;650.0931200974641;651.9282878883322;652.3476523476523;32033.35933281333;43007;44094.77952610241;44171.337429938576;47606.28590571144;44984.3252351215;45406.318905216445;45482.77258613711;45490;45516.3172552412;8115.553644549547;8851.95574022129;9034.45793252407;9040.954795226047;9062.909370906273;7944.960275198645;8188.836223275531;8190.959045204766;10560.577576896914;10843.83734243987;10980.396078215696;11047.116230701566;11050.668479945614;11051.778964420706;11052.171087168454;10797.892021079806;10855.728606784814;10868.347899126038;10878.728031799268;10881.83677244842;10658;10688.931106889326;10724.517396717089;10729.409882456463;10730.463476826128;42722.57277427217;43065.78467107644;43103.137937241394;43182.13635727299;43205.78397108026;3462.272922686239;3462.4979377990303;3462.982685086584;3514.2620049789575;3520.366334059868;30820.69179308223;31720.36559268825;31752.682473175435;31879;31943.041708748773;4085.346344584852;4201.390798334224;4219.831206751726;4236.771336312466;4313.28830742927;318664;319309;320322;321010;321636;59574;59965.40034599685;59966;59976.70011649914;59979.40020599825;63643.681781591724;63662.36337636657;63750;63780;63836;13869.722605547833;13872.375743091585;13911.582652520441;13978.231197284043;13983.37074831635;10707.250492465453;11751.706207344885;11755.294682319089;11801.586944456903;11802.114841386758;15159.848401516065;17363.65272694539;17776.644467110586;17795.19921603531;18538.443846684622;5748.655080695172;6375.171227740364;6424.196975378078;6515.73937042513;6612;950.8811398575178;1016.9644062457926;1039.589362201926;1081.3944191252924;1096.8793432722393;31294.374112517624;31735;32145.678543214737;32163;32400.297988577106;1080.0765345629375;1101.3832253937821;1126.7633796902578;1166.2011522107384;1185.7154282972024;16393.6721265574;16703.57798119266;16816;16968.47954268337;17016.829831701772;453707;456972;457410;457699;457783;54634;55286.72356638191;55779.44220557743;55884.72057639686;57096.71451642715;1241.7081985733346;1254.172246317426;1265.9810102848464;1300.6293206436121;1300.8373953255843;30792.384152317278;33145.668543314256;33342.83328583342;33403.331933360714;33471.83264083664;51163.48836511736;51589.742051291;51694;51714.741426292625;51731.22403164031;419913;428388.43223134737;432647;440677;669476;27044.729552704222;27107.86446067757;27241.727582723917;27337.86331068332;27370.589441158798;46202.53797461982;46627.53372466368;47023;47145.76427117842;47526;39797.40303895502;39948.80025599853;39960.80019599883;40505.797471012454;42002.57997419986;41094.58905410908;41311.39749384935;41918.58081419147;41949.37075943924;41970;39744.60255397409;40151;40302;40311.79844100761;41325.586744132175;34319.31361372808;35671;35835.99494169482;36681.266374671824;36989.63010369862;27613.17117761609;28068.578971315037;28085.71914280913;28120.85939570289;28150.2962425941 19:00:57 INFO - PROCESS | 4912 | |2;jquery.html;362.19231114614394;372.21462713674146;381.92297720428394;384.62499063413173;409.65179597342245;13985.300734963263;17761.20074596643;18234.452966411012;18885.244590216374;19983.703503746692;18127.637447251047;18542.25830966763;18571.90714046428;18780.154893029812;18892.433227003177;5535.474129957658;5843.328017278025;5846.473817356437;5849.327327357366;5857.560682948774;5487.588430867681;5694.6867922264255;5713.800016999406;5775.537956963432;5803.419658034205;5727.513161381266;5731.197632331477;5731.684757338345;5733.885322293551;5735.168400581913;5587.078132108198;5655.717214139318;5663.093904975225;5722.084466485342;5725.198472213872;5114.207297868837;5117.744112794346;5122.897542049175;5123.257127716498;5124.0776660201145;22344.888275558682;22359;22654.43363915899;22691.369380898977;22850.31449056531;2310.306907927615;2313.90744370225;2522.230719630512;2714.429969706364;3026.6216722909635;9568.66509672165;9939;10286.9485652572;10443.686689399254;13683.726325473534;1828.168183476515;1871.1112221694723;1909.284018493065;1911.8183772541586;1989.4031790462802;59684.701576492276;76659.41757280283;76849.61575192088;78802;80060.39577229596;10366.378017318984;10477.84283235752;10498.370097794157;11490.712732181762;11495.942520287344;13950.23273719955;14580.562583122522;14658.853411465749;14716.484923027856;14742.852571474363;7275;7354.705811767576;7485.288897554724;7522.511036782592;7636.045494313211;6890.414314783299;6917.446604271646;7123.180834204029;7126.643667816588;7159.105111861018;4363.912721745547;4464.330350447394;4483.887902802391;4587.619670571427;4680.67235293533;1828.8368199168885;1907.9046047697836;1919.0021188981652;1931.2468137426415;1945.299692110839;886.5877367024235;896.6099746610246;913.3287034029983;970.4759429907771;997.2520609542843;17247.396341128002;18543.258269669062;19514.5121371964;19778.802211977694;19896.303629373193;953.2897990996752;953.726774755695;990.6235630460379;1022.9897701023043;1035.35807799165;8076.676932922617;10503.579856805794;10919.508622112024;10936.617218397318;10958.890411095947;388013;441649;442327;452760;454819;82688.58655706682;83490.26428371498;85120.57439712886;85879.57060214659;86625.56687216523;971.6356366362614;981.8281800684852;986.8322385194534;993.99606397539;1000.8899021107673;15901.443449479213;15953.04281743099;16476.704659068473;16555.420560280334;16732.498025059267;39352.40971385374;39701.80149099236;40112.799436002635;40250;40496;50779.69931954411;53959.73020134874;54424.72787636037;55121.44878551163;59853;7775.717006693832;7907.0739645852855;8034.47775894565;8105.067917189599;8328.167183281623;11265.887341126483;12504.312262825631;12818.423170957143;12856.059517141864;12866.742665146832;10629.202809789142;10819.296745711503;10823.417325804065;10881.782364352826;11171.484675995864;10363.119134873621;11001.889981100407;11083.503726997074;11603.361815099914;11706.180567360203;10843.891561084289;11095.278806877526;11118.110551156049;11134.27627204229;11444.599439019594;7817.413693973089;7998.160193179632;8089.191080891864;8132.959335203286;8435.156484351515;9662;10828.349789842507;11007.669769906915;11008;11240.269382490113 19:00:57 INFO - PROCESS | 4912 | |3;mootools.html;1355.261382546512;1426.4579459805275;1460.5837336359136;1558.9922050389746;1743.8953662780227;7955.284024437799;8753.3872628916;9160.038195989426;9161.541922903853;9420.858687119699;9168.358214924958;9225;9249.861252081224;9257.907420925789;9260.212881905029;2315.583195024895;2319.2810228829035;2344.5310937812505;2345.835791494596;2348.9177878774244;2271.114265436481;2287.645414960684;2335.346103091137;2348.8942997565064;2354.482013956927;2284.3603790938564;2302.8503147295455;2315.3632750993443;2343.8828058597087;2348.189874493297;2280.05377768226;2284.2233640562204;2284.7601001894895;2287.1080278691325;2289.5878741826546;2195.9121635134575;2215.711957445522;2221.622324204889;2222.8999695013763;2223.4324801015246;8900.821983560292;9020.8646870297;9114.316426268057;9117.042710515367;9144.268458523302;5285.286486324336;5488.643238189505;5492.505674489275;5502.394736578973;5505.366882808488;3399.3711163434846;3420.1791570023265;3450.344434557426;3507.8070706111153;3510.596281427617;1046.49768111307;1078.1374900079904;2047.2015913793632;2102.1696429910253;2129.542148438093;12683.302418366986;12707.745845083138;12815.807762883564;12838.550650727273;12845.421956012002;4218.873433796991;4451.688381813242;4504.436945381827;4611.239145541015;4636.420447444069;9934.205263578897;9951.751206219758;9953.153981911619;9956.900430995598;9960.501974901226;5309.946900531023;5310.044192045469;5311.840644780663;5315.601329900195;5320.866978325573;4364.738115713068;4490.3040028795585;4788.640851936118;4885.828995985124;4976.527229913152;3636.072801435617;3671.173985853162;3746.868859589901;3804.6575808177395;3879.86420475282;1142.126273400849;1150.810116330813;1158.3976332307323;1159.3217967489113;1165.4871856383165;755.9622018899033;898.6315610599622;909.9163015921155;918.0544039639183;938.3712912348743;5975.492083172979;6131.877362452726;6245.687715614201;6270.15352927349;6577.605343679299;925.6066171876926;950.0736781637986;961.9230461563199;1005.4168582222294;1008.495752123938;3790.1851102013197;3805.8858234253016;3827.4116241759357;3888.358420860583;3932.9606703932595;11112.16658750597;11511.597094101666;11532;11668.241564298294;11669.35818529972;11486.0811135109;11494.597689080842;11530.88469115315;11535.134864885167;11536.307821530734;7728.381729461629;8473.49159050459;8608.655653773903;8619;8621.439606425687;6082.482988945812;6135.202423684892;6140.3245642978345;6255.655938923221;6297.118403423616;10469.528871200966;10476.109530689977;10503.317284376491;10506.264561480622;10520.473976301308;10295.17638588896;10909.836352454879;11005.724856878642;11048.226624136234;11056.613018544313;7034.929650703428;7265.782026539212;7647.349975252166;8054.556999364857;8209.13804050566;8486.660533578835;8854.690085846965;8873.556322183995;8875.73372798817;8878.73363799087;7609.39124869998;7747.92252077472;7807.531548107132;7861.1745766693675;7870.409719271192;7581.848363032819;7671.156172821097;7692.7692169235015;7712.5758083305955;7742.38060955111;6965.164180298397;7088.503804733826;7089.361957423856;7096.432285417051;7100.218975912749;4928.8767780805765;4938.901221975612;4980.178270585313;4983.202687569971;5198.324217851655;4889.242167464049;4917.164082105979;5005.7997680092385;5008.373953255843;5150.253213283978 19:00:57 INFO - PROCESS | 4912 | |4;prototype.html;325.13027651033497;332.7753766207809;337.93241351729654;339.5280560021569;346.2883773844748;5280.815171468999;5317.367902888076;5328.46715328467;5329.481097887103;5390.73046347683;5021.372328458942;5050.853387310388;5103.366922584774;5164.896702065957;5315.893682126365;4099.97950010251;4111.594717090506;4113.56807535209;4137.2552940470705;4146.917061658765;4079.6532294754834;4120.629143377096;4134.676903390916;4147.087640719052;4169.312063509517;3759.342115129855;3892.143728379752;4012.057166565855;4029.4285228760805;4086.6117718816663;4052.1490486997764;4053.6554392876346;4077.97961010196;4078.8164532596106;4109.815058322398;3593.6047034826147;3595.1012246938267;3597.226596281812;3602.2795440911923;3613.241219343941;4853.907870729093;5106.183010718267;5120.334356533664;5136.486351364871;5175.412293853074;4653.6509761768;4660.603848672867;4682.6019788318035;4694.389729335165;4708.858734237979;5487.917681234745;5506.669599823983;5508.14623733322;5530.668159910419;5532.917006244909;3748.6063963283736;3931.626495482953;3962.7820469874146;3966.3257246267917;3978.761274323521;5637.3517045539875;5638.548916086703;5671;5675.063614503643;5680;4029.536603290659;4032.455618491466;4034.959650403517;4039.555648878621;4039.6566291864933;3894.6689531389584;4057.5739547347694;4105.220008198433;4121.1345617420075;4122.42286079949;4652.697574657636;4667.696599721007;4668.719876807402;4705.482396936334;4737.123632128068;5472.945270547323;5498.285222920995;5505.403433004464;5561.360443549043;5582.637128586629;1345.9596212113652;1392.9860701392856;1413.1591702936737;1416.6175132714109;1418.1491105336715;894.4722613657973;899.8470260055806;905.805251870851;916.9633214671338;921.3228277216241;4577.473590537131;4627.745473998895;4630.282306242538;4691.319758634979;4711.74085425298;4520.706154099973;4907.552272079745;4925.359703238628;4946.378419437704;4966.9817687374;4666.0402630895105;4690.859274221711;4698.345434829311;4702.764861756898;4721.575058244705;2621.820180918556;2639.0998481093584;2654.7345265473687;2656.6811982562217;2672.4387878545335;4790.640701947368;5016.2224855147515;5045.772940217699;5091.974540127349;5142.434332223453;4865.537773911544;4907.877303067452;4927.852164435073;4940.258961155855;4992.450830408652;4929.3345398371475;5048.788290810253;5082.771275292621;5088.465711100355;5137.023965446553;4934.851954441372;4940.949505954988;4976.581674222829;5010.273510341053;5250.711210883438;5609.551235901036;5633.155026746021;5651.660900345993;5660.688662123623;5685.687287199244;5829;5850.912236316543;5874.853128671817;5939.762409503572;5943.851403714942;3911;4073.4297198391655;4088.4480595120467;4088.4684990950987;4122.361034039729;5394.757235924314;5402.5677945763455;5517.806876759294;5525.254090697705;5585.525230355465;5388.434214407431;5402.216678581663;5407.648087978006;5424.918626220689;5454.290942177491;5294.444083371344;5487.835364939058;5490.478404551562;5510;5515.338159420895;5444.945550544444;5455.972720136533;5499.890002200013;5508.862278443071;5513.751881165277;5475.370332411823;5508.338999319947;5514.6691198528215;5518.779248830162;5535;5240.030594340059;5383.434739352311;5405.594580406407;5423;5428.83713488596 19:00:57 INFO - PROCESS | 4912 | |5;yui.html;717.6662851773925;781.1173374087281;788.3929374381722;811.5536454949776;867.5705525764746;15340.846591534082;16415.507534773962;16513.091779952098;16523.669526609476;16567.17164141791;15239.390424383038;16071.839281607181;16149.596260093504;16164.191790410461;16231.107289099094;817.6606708216098;834.9582520873962;837.3259526081501;837.7905523619095;838.2748922182299;664.5049438168571;697.0450482838519;791.4103992525577;821.4003777242586;821.8931538899934;871.904090550039;873.6112429968666;873.9868901966476;874.0123660263893;874.2306770042354;864.3603733237422;864.8400045991481;864.9221570058662;864.9740507784777;865.2040123086744;516.3803435876926;534.3480953237045;605.6063558686889;629.2040568680577;636.017353189319;14814.925925370411;14845.554633361016;14866.108033518023;14878.925605371904;14900.850991490055;13695.86304136956;14258.857411425857;14290.428382864673;14392.712145757027;14411.423543058265;12203.816942745865;12485.188462749893;12515.749685006249;12594.118411711184;12671.2397256164;4309.116631090619;4383.473983122014;4405.383246345515;4568.5431456854385;4570.154521413516;60061;74235.62882185608;75473.62263188759;76568.21772081024;76868;10873.644912056552;10877.401742904058;11100.426019581888;11349.716257093638;11502.827457588142;20868.47828804292;20888.58222835565;20911.68632470514;20917.163313467594;20948;7883.802904927308;8169.42814003026;8228.341732661373;8293.21214484623;8352.749417517483;4625.976870115695;4694.788734506956;4714.717116972993;4730.053989202104;4919.827806026772;3245.4482737934136;3345.1135449106005;3351.4135026370286;3351.9664803352143;3354.9329013419597;605.4187979539691;607.2348840460962;615.2125279642065;618.4835662222005;634.1407392982535;625.8623102917351;632.8481164520574;671.1442910289322;671.1945665201778;674.9032821664795;8484.957575212084;8710.346723995726;8984.101589840964;9215;9297.070292970784;528.1892295326655;613.8404014956054;668.5220067651555;680.6562685843618;691.3432239372515;4340.348947657877;4411.867643970686;4434.201843668106;4439.378487011821;4509.909801803946;112056.43971780252;113709;114616.42691786488;115148.42425787984;115687.42156289164;76400;103622;104053.47973260237;105898.47050764697;106596;49775.25337120018;63054.369456305765;72990.27009729834;79182.20817791864;80573;8791.868121978303;9120.45277283365;9620.182284505896;9660.178884794872;9692.33762540735;46153.538464614925;46188.22423739479;46628.7668561655;46826.53173468222;47708;46917.765411172724;49154.75422622864;60311;60874.08688869759;66298.66850665715;12720.618381448572;12934.741305174031;12951;13317.733645326845;13795.310234488035;13642.658933526742;13976.860231397555;14098.718025639635;14140.363683634056;14392.496262631177;13046.428321975223;13324.666883327995;13728;13757.518486852912;13878.306084695927;13174.419069711696;13220.548258934488;13420.731585368043;13511.121777084458;13582;12074.39628018613;12147.817782733442;12277.447514862031;12298.642805069057;12456.12807103494;9868.111869931741;10042.548085336324;10191.612615734952;10400.61785848662;10649.254552181274;10221.25365487978;10996.670099897015;11012.889871101506;11020;11067.169962252703 19:00:57 INFO - PROCESS | 4912 | __end_tp_report 19:00:57 INFO - PROCESS | 4912 | __start_cc_report 19:00:57 INFO - PROCESS | 4912 | _x_x_mozilla_cycle_collect,2360 19:00:57 INFO - PROCESS | 4912 | __end_cc_report 19:00:57 INFO - PROCESS | 4912 | __startTimestamp1477360857360__endTimestamp 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | ------- Summary: start ------- 19:00:57 INFO - PROCESS | 4912 | Number of tests: 6 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#0] dojo.html Cycles:165 Average:5374.29 Median:5587.86 stddev:610.02 (10.9%) stddev-sans-first:584.25 19:00:57 INFO - PROCESS | 4912 | Values: 3060.1 3078.0 3114.8 3126.7 3128.3 5261.2 5370.5 5382.0 5458.2 5468.9 5378.1 5416.7 5445.9 5468.0 5480.9 4892.3 4894.0 4940.4 4947.1 4973.2 4907.2 5006.4 5023.4 5029.7 5094.1 4817.8 4854.4 4969.8 5023.8 5041.7 4879.8 4910.1 4914.4 4957.8 4988.5 4865.9 4903.8 4909.9 4957.5 4970.0 5417.2 5419.0 5420.5 5430.5 5491.2 5644.4 5652.6 5697.1 5777.5 5780.3 5746.0 5836.6 5851.8 5853.3 5855.2 5339.4 5351.5 5356.3 5358.9 5359.5 5808.5 5811.2 5867.4 5873.3 5875.4 5587.9 5591.5 5629.9 5637.2 5648.6 5678.8 5683.3 5684.8 5685.9 5750.4 5776.0 5779.9 5783.1 5783.5 5787.5 5580.7 5691.0 5691.5 5708.0 5862.7 4381.1 4403.4 4404.2 4417.0 4456.3 3917.4 3934.1 3936.3 3970.7 3976.7 5328.1 5359.3 5454.5 5484.9 5490.9 5865.9 5866.0 5867.5 5883.8 5911.0 5510.2 5516.8 5517.3 5518.9 5519.2 4937.0 4978.4 5044.4 5050.1 5118.1 6050.3 6096.9 6101.5 6105.7 6107.5 5890.5 5892.9 5895.2 5901.7 5942.8 5853.2 5899.3 5962.6 6038.5 6049.5 5646.8 5669.2 5671.8 5683.0 5685.7 5749.9 5751.7 5752.6 5754.0 5760.9 5652.0 5656.6 5657.6 5657.7 5659.4 5603.0 5649.8 5656.4 5657.8 5659.4 5634.4 5640.5 5664.2 5667.9 5668.9 5563.7 5607.1 5709.4 5719.5 5721.0 5427.1 5501.9 5517.0 5529.9 5534.3 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#1] ext.html Cycles:180 Average:58384.41 Median:36835.45 stddev:113358.79 (307.7%) stddev-sans-first:113593.76 19:00:57 INFO - PROCESS | 4912 | Values: 597.4 620.0 650.1 651.9 652.3 32033.4 43007.0 44094.8 44171.3 47606.3 44984.3 45406.3 45482.8 45490.0 45516.3 8115.6 8852.0 9034.5 9041.0 9062.9 7945.0 8188.8 8191.0 10560.6 10843.8 10980.4 11047.1 11050.7 11051.8 11052.2 10797.9 10855.7 10868.3 10878.7 10881.8 10658.0 10688.9 10724.5 10729.4 10730.5 42722.6 43065.8 43103.1 43182.1 43205.8 3462.3 3462.5 3463.0 3514.3 3520.4 30820.7 31720.4 31752.7 31879.0 31943.0 4085.3 4201.4 4219.8 4236.8 4313.3 318664.0 319309.0 320322.0 321010.0 321636.0 59574.0 59965.4 59966.0 59976.7 59979.4 63643.7 63662.4 63750.0 63780.0 63836.0 13869.7 13872.4 13911.6 13978.2 13983.4 10707.3 11751.7 11755.3 11801.6 11802.1 15159.8 17363.7 17776.6 17795.2 18538.4 5748.7 6375.2 6424.2 6515.7 6612.0 950.9 1017.0 1039.6 1081.4 1096.9 31294.4 31735.0 32145.7 32163.0 32400.3 1080.1 1101.4 1126.8 1166.2 1185.7 16393.7 16703.6 16816.0 16968.5 17016.8 453707.0 456972.0 457410.0 457699.0 457783.0 54634.0 55286.7 55779.4 55884.7 57096.7 1241.7 1254.2 1266.0 1300.6 1300.8 30792.4 33145.7 33342.8 33403.3 33471.8 51163.5 51589.7 51694.0 51714.7 51731.2 419913.0 428388.4 432647.0 440677.0 669476.0 27044.7 27107.9 27241.7 27337.9 27370.6 46202.5 46627.5 47023.0 47145.8 47526.0 39797.4 39948.8 39960.8 40505.8 42002.6 41094.6 41311.4 41918.6 41949.4 41970.0 39744.6 40151.0 40302.0 40311.8 41325.6 34319.3 35671.0 35836.0 36681.3 36989.6 27613.2 28068.6 28085.7 28120.9 28150.3 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#2] jquery.html Cycles:180 Average:26660.71 Median:39907.30 stddev:72051.59 (180.5%) stddev-sans-first:72226.66 19:00:57 INFO - PROCESS | 4912 | Values: 362.2 372.2 381.9 384.6 409.7 13985.3 17761.2 18234.5 18885.2 19983.7 18127.6 18542.3 18571.9 18780.2 18892.4 5535.5 5843.3 5846.5 5849.3 5857.6 5487.6 5694.7 5713.8 5775.5 5803.4 5727.5 5731.2 5731.7 5733.9 5735.2 5587.1 5655.7 5663.1 5722.1 5725.2 5114.2 5117.7 5122.9 5123.3 5124.1 22344.9 22359.0 22654.4 22691.4 22850.3 2310.3 2313.9 2522.2 2714.4 3026.6 9568.7 9939.0 10286.9 10443.7 13683.7 1828.2 1871.1 1909.3 1911.8 1989.4 59684.7 76659.4 76849.6 78802.0 80060.4 10366.4 10477.8 10498.4 11490.7 11495.9 13950.2 14580.6 14658.9 14716.5 14742.9 7275.0 7354.7 7485.3 7522.5 7636.0 6890.4 6917.4 7123.2 7126.6 7159.1 4363.9 4464.3 4483.9 4587.6 4680.7 1828.8 1907.9 1919.0 1931.2 1945.3 886.6 896.6 913.3 970.5 997.3 17247.4 18543.3 19514.5 19778.8 19896.3 953.3 953.7 990.6 1023.0 1035.4 8076.7 10503.6 10919.5 10936.6 10958.9 388013.0 441649.0 442327.0 452760.0 454819.0 82688.6 83490.3 85120.6 85879.6 86625.6 971.6 981.8 986.8 994.0 1000.9 15901.4 15953.0 16476.7 16555.4 16732.5 39352.4 39701.8 40112.8 40250.0 40496.0 50779.7 53959.7 54424.7 55121.4 59853.0 7775.7 7907.1 8034.5 8105.1 8328.2 11265.9 12504.3 12818.4 12856.1 12866.7 10629.2 10819.3 10823.4 10881.8 11171.5 10363.1 11001.9 11083.5 11603.4 11706.2 10843.9 11095.3 11118.1 11134.3 11444.6 7817.4 7998.2 8089.2 8133.0 8435.2 9662.0 10828.3 11007.7 11008.0 11240.3 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#3] mootools.html Cycles:180 Average:5910.10 Median:4887.54 stddev:3441.52 (70.4%) stddev-sans-first:3434.15 19:00:57 INFO - PROCESS | 4912 | Values: 1355.3 1426.5 1460.6 1559.0 1743.9 7955.3 8753.4 9160.0 9161.5 9420.9 9168.4 9225.0 9249.9 9257.9 9260.2 2315.6 2319.3 2344.5 2345.8 2348.9 2271.1 2287.6 2335.3 2348.9 2354.5 2284.4 2302.9 2315.4 2343.9 2348.2 2280.1 2284.2 2284.8 2287.1 2289.6 2195.9 2215.7 2221.6 2222.9 2223.4 8900.8 9020.9 9114.3 9117.0 9144.3 5285.3 5488.6 5492.5 5502.4 5505.4 3399.4 3420.2 3450.3 3507.8 3510.6 1046.5 1078.1 2047.2 2102.2 2129.5 12683.3 12707.7 12815.8 12838.6 12845.4 4218.9 4451.7 4504.4 4611.2 4636.4 9934.2 9951.8 9953.2 9956.9 9960.5 5309.9 5310.0 5311.8 5315.6 5320.9 4364.7 4490.3 4788.6 4885.8 4976.5 3636.1 3671.2 3746.9 3804.7 3879.9 1142.1 1150.8 1158.4 1159.3 1165.5 756.0 898.6 909.9 918.1 938.4 5975.5 6131.9 6245.7 6270.2 6577.6 925.6 950.1 961.9 1005.4 1008.5 3790.2 3805.9 3827.4 3888.4 3933.0 11112.2 11511.6 11532.0 11668.2 11669.4 11486.1 11494.6 11530.9 11535.1 11536.3 7728.4 8473.5 8608.7 8619.0 8621.4 6082.5 6135.2 6140.3 6255.7 6297.1 10469.5 10476.1 10503.3 10506.3 10520.5 10295.2 10909.8 11005.7 11048.2 11056.6 7034.9 7265.8 7647.3 8054.6 8209.1 8486.7 8854.7 8873.6 8875.7 8878.7 7609.4 7747.9 7807.5 7861.2 7870.4 7581.8 7671.2 7692.8 7712.6 7742.4 6965.2 7088.5 7089.4 7096.4 7100.2 4928.9 4938.9 4980.2 4983.2 5198.3 4889.2 4917.2 5005.8 5008.4 5150.3 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#4] prototype.html Cycles:180 Average:4481.52 Median:4940.60 stddev:1303.27 (26.4%) stddev-sans-first:1269.04 19:00:57 INFO - PROCESS | 4912 | Values: 325.1 332.8 337.9 339.5 346.3 5280.8 5317.4 5328.5 5329.5 5390.7 5021.4 5050.9 5103.4 5164.9 5315.9 4100.0 4111.6 4113.6 4137.3 4146.9 4079.7 4120.6 4134.7 4147.1 4169.3 3759.3 3892.1 4012.1 4029.4 4086.6 4052.1 4053.7 4078.0 4078.8 4109.8 3593.6 3595.1 3597.2 3602.3 3613.2 4853.9 5106.2 5120.3 5136.5 5175.4 4653.7 4660.6 4682.6 4694.4 4708.9 5487.9 5506.7 5508.1 5530.7 5532.9 3748.6 3931.6 3962.8 3966.3 3978.8 5637.4 5638.5 5671.0 5675.1 5680.0 4029.5 4032.5 4035.0 4039.6 4039.7 3894.7 4057.6 4105.2 4121.1 4122.4 4652.7 4667.7 4668.7 4705.5 4737.1 5472.9 5498.3 5505.4 5561.4 5582.6 1346.0 1393.0 1413.2 1416.6 1418.1 894.5 899.8 905.8 917.0 921.3 4577.5 4627.7 4630.3 4691.3 4711.7 4520.7 4907.6 4925.4 4946.4 4967.0 4666.0 4690.9 4698.3 4702.8 4721.6 2621.8 2639.1 2654.7 2656.7 2672.4 4790.6 5016.2 5045.8 5092.0 5142.4 4865.5 4907.9 4927.9 4940.3 4992.5 4929.3 5048.8 5082.8 5088.5 5137.0 4934.9 4940.9 4976.6 5010.3 5250.7 5609.6 5633.2 5651.7 5660.7 5685.7 5829.0 5850.9 5874.9 5939.8 5943.9 3911.0 4073.4 4088.4 4088.5 4122.4 5394.8 5402.6 5517.8 5525.3 5585.5 5388.4 5402.2 5407.6 5424.9 5454.3 5294.4 5487.8 5490.5 5510.0 5515.3 5444.9 5456.0 5499.9 5508.9 5513.8 5475.4 5508.3 5514.7 5518.8 5535.0 5240.0 5383.4 5405.6 5423.0 5428.8 19:00:57 INFO - PROCESS | 4912 | 19:00:57 INFO - PROCESS | 4912 | [#5] yui.html Cycles:180 Average:19503.01 Median:4539.23 stddev:28023.09 (617.4%) stddev-sans-first:28066.20 19:00:57 INFO - PROCESS | 4912 | Values: 717.7 781.1 788.4 811.6 867.6 15340.8 16415.5 16513.1 16523.7 16567.2 15239.4 16071.8 16149.6 16164.2 16231.1 817.7 835.0 837.3 837.8 838.3 664.5 697.0 791.4 821.4 821.9 871.9 873.6 874.0 874.0 874.2 864.4 864.8 864.9 865.0 865.2 516.4 534.3 605.6 629.2 636.0 14814.9 14845.6 14866.1 14878.9 14900.9 13695.9 14258.9 14290.4 14392.7 14411.4 12203.8 12485.2 12515.7 12594.1 12671.2 4309.1 4383.5 4405.4 4568.5 4570.2 60061.0 74235.6 75473.6 76568.2 76868.0 10873.6 10877.4 11100.4 11349.7 11502.8 20868.5 20888.6 20911.7 20917.2 20948.0 7883.8 8169.4 8228.3 8293.2 8352.7 4626.0 4694.8 4714.7 4730.1 4919.8 3245.4 3345.1 3351.4 3352.0 3354.9 605.4 607.2 615.2 618.5 634.1 625.9 632.8 671.1 671.2 674.9 8485.0 8710.3 8984.1 9215.0 9297.1 528.2 613.8 668.5 680.7 691.3 4340.3 4411.9 4434.2 4439.4 4509.9 112056.4 113709.0 114616.4 115148.4 115687.4 76400.0 103622.0 104053.5 105898.5 106596.0 49775.3 63054.4 72990.3 79182.2 80573.0 8791.9 9120.5 9620.2 9660.2 9692.3 46153.5 46188.2 46628.8 46826.5 47708.0 46917.8 49154.8 60311.0 60874.1 66298.7 12720.6 12934.7 12951.0 13317.7 13795.3 13642.7 13976.9 14098.7 14140.4 14392.5 13046.4 13324.7 13728.0 13757.5 13878.3 13174.4 13220.5 13420.7 13511.1 13582.0 12074.4 12147.8 12277.4 12298.6 12456.1 9868.1 10042.5 10191.6 10400.6 10649.3 10221.3 10996.7 11012.9 11020.0 11067.2 19:00:57 INFO - PROCESS | 4912 | -------- Summary: end -------- 19:00:57 INFO - PROCESS | 4912 | 19:00:58 INFO - TEST-INFO | 4912: exit 0 19:00:58 INFO - TEST-OK | dromaeo_css | took 1119430ms 19:00:58 INFO - TEST-START | kraken 19:00:58 INFO - operating with platform_type : linux_ 19:00:58 INFO - Initialising browser for kraken test... 19:00:58 INFO - TEST-INFO | started process 5223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCP4C9l/profile http://localhost:49151/getInfo.html) 19:01:02 INFO - PROCESS | 5223 | __metrics Screen width/height:1600/1200 19:01:02 INFO - PROCESS | 5223 | colorDepth:24 19:01:02 INFO - PROCESS | 5223 | Browser inner width/height: 1024/697 19:01:02 INFO - PROCESS | 5223 | __metrics 19:01:03 INFO - PROCESS | 5223 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:01:03 INFO - PROCESS | 5223 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:01:03 INFO - PROCESS | 5223 | console.error: PushService: 19:01:03 INFO - PROCESS | 5223 | stateChangeProcessEnqueue: Error transitioning state 19:01:03 INFO - PROCESS | 5223 | UnknownError 19:01:04 INFO - TEST-INFO | 5223: exit 0 19:01:04 INFO - Browser initialized. 19:01:04 INFO - Running cycle 1/1 for kraken test... 19:01:04 INFO - TEST-INFO | started process 5309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCP4C9l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:16 INFO - PROCESS | 5309 | RSS: Main: 171995136 19:01:16 INFO - PROCESS | 5309 | 19:01:19 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49151/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:20 INFO - PROCESS | 5309 | RSS: Main: 229216256 19:01:20 INFO - PROCESS | 5309 | 19:01:22 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49151/tests/kraken/driver.html?testName=audio-dft) 19:01:23 INFO - PROCESS | 5309 | RSS: Main: 216006656 19:01:23 INFO - PROCESS | 5309 | 19:01:26 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49151/tests/kraken/driver.html?testName=audio-fft) 19:01:27 INFO - PROCESS | 5309 | RSS: Main: 297881600 19:01:27 INFO - PROCESS | 5309 | 19:01:29 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49151/tests/kraken/driver.html?testName=audio-oscillator) 19:01:29 INFO - PROCESS | 5309 | RSS: Main: 209317888 19:01:29 INFO - PROCESS | 5309 | 19:01:31 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:32 INFO - PROCESS | 5309 | RSS: Main: 211947520 19:01:32 INFO - PROCESS | 5309 | 19:01:35 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49151/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:36 INFO - PROCESS | 5309 | RSS: Main: 248627200 19:01:36 INFO - PROCESS | 5309 | 19:01:39 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49151/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:40 INFO - PROCESS | 5309 | RSS: Main: 246865920 19:01:40 INFO - PROCESS | 5309 | 19:01:42 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49151/tests/kraken/driver.html?testName=json-parse-financial) 19:01:43 INFO - PROCESS | 5309 | RSS: Main: 246816768 19:01:43 INFO - PROCESS | 5309 | 19:01:44 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:45 INFO - PROCESS | 5309 | RSS: Main: 209326080 19:01:45 INFO - PROCESS | 5309 | 19:01:47 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:47 INFO - PROCESS | 5309 | RSS: Main: 216526848 19:01:47 INFO - PROCESS | 5309 | 19:01:49 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:50 INFO - PROCESS | 5309 | RSS: Main: 225996800 19:01:50 INFO - PROCESS | 5309 | 19:01:53 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:53 INFO - PROCESS | 5309 | RSS: Main: 234921984 19:01:53 INFO - PROCESS | 5309 | 19:01:56 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:57 INFO - PROCESS | 5309 | RSS: Main: 231919616 19:01:57 INFO - PROCESS | 5309 | 19:01:58 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:49151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49151/tests/kraken/driver.html?testName=ai-astar) 19:01:59 INFO - PROCESS | 5309 | RSS: Main: 281317376 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | __start_tp_report 19:01:59 INFO - PROCESS | 5309 | _x_x_mozilla_page_load 19:01:59 INFO - PROCESS | 5309 | _x_x_mozilla_page_load_details 19:01:59 INFO - PROCESS | 5309 | |i|pagename|runs| 19:01:59 INFO - PROCESS | 5309 | |0;ai-astar;105;111;111;111;112;112;113;110;110;111 19:01:59 INFO - PROCESS | 5309 | |1;audio-beat-detection;151;124;122;163;124;126;127;123;160;129 19:01:59 INFO - PROCESS | 5309 | |2;audio-dft;161;161;161;162;162;162;161;162;162;163 19:01:59 INFO - PROCESS | 5309 | |3;audio-fft;76;76;75;115;78;77;76;76;101;77 19:01:59 INFO - PROCESS | 5309 | |4;audio-oscillator;84;83;110;83;83;84;115;83;83;125 19:01:59 INFO - PROCESS | 5309 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;117 19:01:59 INFO - PROCESS | 5309 | |6;imaging-darkroom;147;148;147;148;147;148;147;147;147;147 19:01:59 INFO - PROCESS | 5309 | |7;imaging-desaturate;85;85;84;85;85;84;84;83;84;85 19:01:59 INFO - PROCESS | 5309 | |8;json-parse-financial;54;52;51;52;53;62;55;53;52;53 19:01:59 INFO - PROCESS | 5309 | |9;json-stringify-tinderbox;58;59;59;60;60;60;59;59;59;59 19:01:59 INFO - PROCESS | 5309 | |10;stanford-crypto-aes;87;80;80;80;80;79;80;79;80;79 19:01:59 INFO - PROCESS | 5309 | |11;stanford-crypto-ccm;155;132;129;140;129;140;128;145;177;135 19:01:59 INFO - PROCESS | 5309 | |12;stanford-crypto-pbkdf2;167;172;164;170;167;164;166;171;171;173 19:01:59 INFO - PROCESS | 5309 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;66;66;67;66;67 19:01:59 INFO - PROCESS | 5309 | __end_tp_report 19:01:59 INFO - PROCESS | 5309 | __start_cc_report 19:01:59 INFO - PROCESS | 5309 | _x_x_mozilla_cycle_collect,1687 19:01:59 INFO - PROCESS | 5309 | __end_cc_report 19:01:59 INFO - PROCESS | 5309 | __startTimestamp1477360919065__endTimestamp 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | ------- Summary: start ------- 19:01:59 INFO - PROCESS | 5309 | Number of tests: 14 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.17 (2.0%) stddev-sans-first:0.97 19:01:59 INFO - PROCESS | 5309 | Values: 105.0 111.0 111.0 111.0 112.0 112.0 113.0 110.0 110.0 111.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:128.00 stddev:16.33 (12.8%) stddev-sans-first:16.25 19:01:59 INFO - PROCESS | 5309 | Values: 151.0 124.0 122.0 163.0 124.0 126.0 127.0 123.0 160.0 129.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:01:59 INFO - PROCESS | 5309 | Values: 161.0 161.0 161.0 162.0 162.0 162.0 161.0 162.0 162.0 163.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.76 (18.1%) stddev-sans-first:14.38 19:01:59 INFO - PROCESS | 5309 | Values: 76.0 76.0 75.0 115.0 78.0 77.0 76.0 76.0 101.0 77.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.53 (19.9%) stddev-sans-first:17.18 19:01:59 INFO - PROCESS | 5309 | Values: 84.0 83.0 110.0 83.0 83.0 84.0 115.0 83.0 83.0 125.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:01:59 INFO - PROCESS | 5309 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:01:59 INFO - PROCESS | 5309 | Values: 147.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 19:01:59 INFO - PROCESS | 5309 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 84.0 83.0 84.0 85.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.13 (5.9%) stddev-sans-first:3.32 19:01:59 INFO - PROCESS | 5309 | Values: 54.0 52.0 51.0 52.0 53.0 62.0 55.0 53.0 52.0 53.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 19:01:59 INFO - PROCESS | 5309 | Values: 58.0 59.0 59.0 60.0 60.0 60.0 59.0 59.0 59.0 59.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:2.37 (3.0%) stddev-sans-first:0.50 19:01:59 INFO - PROCESS | 5309 | Values: 87.0 80.0 80.0 80.0 80.0 79.0 80.0 79.0 80.0 79.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:140.00 stddev:15.22 (10.9%) stddev-sans-first:15.27 19:01:59 INFO - PROCESS | 5309 | Values: 155.0 132.0 129.0 140.0 129.0 140.0 128.0 145.0 177.0 135.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:170.50 stddev:3.31 (1.9%) stddev-sans-first:3.46 19:01:59 INFO - PROCESS | 5309 | Values: 167.0 172.0 164.0 170.0 167.0 164.0 166.0 171.0 171.0 173.0 19:01:59 INFO - PROCESS | 5309 | 19:01:59 INFO - PROCESS | 5309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 19:01:59 INFO - PROCESS | 5309 | Values: 66.0 67.0 65.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 19:01:59 INFO - PROCESS | 5309 | -------- Summary: end -------- 19:01:59 INFO - PROCESS | 5309 | 19:02:00 INFO - TEST-INFO | 5309: exit 0 19:02:00 INFO - TEST-OK | kraken | took 62053ms 19:02:00 INFO - SUITE-END | took 1181s 19:02:00 INFO - Completed test suite (00:19:41) 19:02:00 INFO - javascript benchmark 19:02:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.066679662703, 3077.9538306925388, 3114.8131112133265, 3126.6873312668736, 3128.3117714102905, 5261.158214685651, 5370.516653501184, 5381.973090134548, 5458.208559758833, 5468.863278418036, 5378.112611419121, 5416.702081385522, 5445.945540544593, 5468.043092458824, 5480.945190548094, 4892.315075889378, 4893.951060489403, 4940.357753492059, 4947.084789313971, 4973.204287314031, 4907.190313598252, 5006.374203224597, 5023.422306434752, 5029.698218106907, 5094.1085310070775, 4817.807287708522, 4854.393200849894, 4969.826056088055, 5023.799048038074, 5041.747912604355, 4879.82920597781, 4910.091633047898, 4914.3611330527165, 4957.752112394366, 4988.5260900214425, 4865.927011094836, 4903.779329930162, 4909.901801963941, 4957.479464656231, 4970.0, 5417.241586177938, 5418.972905135449, 5420.485053919911, 5430.51125398716, 5491.176323551459, 5644.3508996465525, 5652.604317697763, 5697.0599851024535, 5777.480026797566, 5780.3063632363965, 5745.971270143623, 5836.5914385993, 5851.824445266649, 5853.29760428747, 5855.209546711182, 5339.439358867341, 5351.518363347279, 5356.303680521507, 5358.892822143535, 5359.490848369438, 5808.5353171747, 5811.215485909433, 5867.413258674099, 5873.295204575393, 5875.383084776123, 5587.8603034923635, 5591.496765291144, 5629.915551266734, 5637.210790489335, 5648.604597678123, 5678.772849086073, 5683.2895888014, 5684.8294551163535, 5685.886282274331, 5750.418634875359, 5775.971120144372, 5779.942200577941, 5783.103618939072, 5783.450572195635, 5787.479126878601, 5580.693061881636, 5691.0, 5691.544676425876, 5707.971460142756, 5862.677552734641, 4381.145676593097, 4403.383526306319, 4404.207242696281, 4417.0, 4456.264716321835, 3917.4319723639915, 3934.075492259317, 3936.291467535814, 3970.741901776433, 3976.681865450757, 5328.120860058125, 5359.330083739533, 5454.53636440899, 5484.862878427992, 5490.862728431821, 5865.912011319833, 5866.032104702762, 5867.530597552186, 5883.823485295448, 5911.024680927685, 5510.201020851954, 5516.834494965157, 5517.337919449692, 5518.91721624176, 5519.172124181325, 4936.975315123474, 4978.427480839678, 5044.394672639307, 5050.065737838511, 5118.078745825787, 6050.273967123973, 6096.88955463735, 6101.459346768484, 6105.732692890381, 6107.46191531438, 5890.528757699288, 5892.852678683067, 5895.233619629421, 5901.704914754159, 5942.762289508371, 5853.239078919713, 5899.262592175978, 5962.5528085394635, 6038.456538911519, 6049.546284028627, 5646.830595082154, 5669.177969194361, 5671.773129074791, 5683.033884239772, 5685.687287199244, 5749.856253593526, 5751.683657398883, 5752.626079304831, 5754.021816291157, 5760.884782304247, 5652.039153343859, 5656.60403771732, 5657.60396772222, 5657.717114144359, 5659.377468478547, 5603.047481928001, 5649.774009039593, 5656.377798442086, 5657.8019769307875, 5659.377468478382, 5634.380218175916, 5640.54875609942, 5664.178694089416, 5667.943320566907, 5668.858278543069, 5563.666180029211, 5607.102863541813, 5709.429057094258, 5719.542436604978, 5721.0, 5427.077396842626, 5501.944980550304, 5516.972415137899, 5529.889402212014, 5534.252875861707], "value": 5332.796905470649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4025974025973, 619.9535034872385, 650.0931200974641, 651.9282878883322, 652.3476523476523, 32033.35933281333, 43007.0, 44094.77952610241, 44171.337429938576, 47606.28590571144, 44984.3252351215, 45406.318905216445, 45482.77258613711, 45490.0, 45516.3172552412, 8115.553644549547, 8851.95574022129, 9034.45793252407, 9040.954795226047, 9062.909370906273, 7944.960275198645, 8188.836223275531, 8190.959045204766, 10560.577576896914, 10843.83734243987, 10980.396078215696, 11047.116230701566, 11050.668479945614, 11051.778964420706, 11052.171087168454, 10797.892021079806, 10855.728606784814, 10868.347899126038, 10878.728031799268, 10881.83677244842, 10658.0, 10688.931106889326, 10724.517396717089, 10729.409882456463, 10730.463476826128, 42722.57277427217, 43065.78467107644, 43103.137937241394, 43182.13635727299, 43205.78397108026, 3462.272922686239, 3462.4979377990303, 3462.982685086584, 3514.2620049789575, 3520.366334059868, 30820.69179308223, 31720.36559268825, 31752.682473175435, 31879.0, 31943.041708748773, 4085.346344584852, 4201.390798334224, 4219.831206751726, 4236.771336312466, 4313.28830742927, 318664.0, 319309.0, 320322.0, 321010.0, 321636.0, 59574.0, 59965.40034599685, 59966.0, 59976.70011649914, 59979.40020599825, 63643.681781591724, 63662.36337636657, 63750.0, 63780.0, 63836.0, 13869.722605547833, 13872.375743091585, 13911.582652520441, 13978.231197284043, 13983.37074831635, 10707.250492465453, 11751.706207344885, 11755.294682319089, 11801.586944456903, 11802.114841386758, 15159.848401516065, 17363.65272694539, 17776.644467110586, 17795.19921603531, 18538.443846684622, 5748.655080695172, 6375.171227740364, 6424.196975378078, 6515.73937042513, 6612.0, 950.8811398575178, 1016.9644062457926, 1039.589362201926, 1081.3944191252924, 1096.8793432722393, 31294.374112517624, 31735.0, 32145.678543214737, 32163.0, 32400.297988577106, 1080.0765345629375, 1101.3832253937821, 1126.7633796902578, 1166.2011522107384, 1185.7154282972024, 16393.6721265574, 16703.57798119266, 16816.0, 16968.47954268337, 17016.829831701772, 453707.0, 456972.0, 457410.0, 457699.0, 457783.0, 54634.0, 55286.72356638191, 55779.44220557743, 55884.72057639686, 57096.71451642715, 1241.7081985733346, 1254.172246317426, 1265.9810102848464, 1300.6293206436121, 1300.8373953255843, 30792.384152317278, 33145.668543314256, 33342.83328583342, 33403.331933360714, 33471.83264083664, 51163.48836511736, 51589.742051291, 51694.0, 51714.741426292625, 51731.22403164031, 419913.0, 428388.43223134737, 432647.0, 440677.0, 669476.0, 27044.729552704222, 27107.86446067757, 27241.727582723917, 27337.86331068332, 27370.589441158798, 46202.53797461982, 46627.53372466368, 47023.0, 47145.76427117842, 47526.0, 39797.40303895502, 39948.80025599853, 39960.80019599883, 40505.797471012454, 42002.57997419986, 41094.58905410908, 41311.39749384935, 41918.58081419147, 41949.37075943924, 41970.0, 39744.60255397409, 40151.0, 40302.0, 40311.79844100761, 41325.586744132175, 34319.31361372808, 35671.0, 35835.99494169482, 36681.266374671824, 36989.63010369862, 27613.17117761609, 28068.578971315037, 28085.71914280913, 28120.85939570289, 28150.2962425941], "value": 20074.051044162792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.19231114614394, 372.21462713674146, 381.92297720428394, 384.62499063413173, 409.65179597342245, 13985.300734963263, 17761.20074596643, 18234.452966411012, 18885.244590216374, 19983.703503746692, 18127.637447251047, 18542.25830966763, 18571.90714046428, 18780.154893029812, 18892.433227003177, 5535.474129957658, 5843.328017278025, 5846.473817356437, 5849.327327357366, 5857.560682948774, 5487.588430867681, 5694.6867922264255, 5713.800016999406, 5775.537956963432, 5803.419658034205, 5727.513161381266, 5731.197632331477, 5731.684757338345, 5733.885322293551, 5735.168400581913, 5587.078132108198, 5655.717214139318, 5663.093904975225, 5722.084466485342, 5725.198472213872, 5114.207297868837, 5117.744112794346, 5122.897542049175, 5123.257127716498, 5124.0776660201145, 22344.888275558682, 22359.0, 22654.43363915899, 22691.369380898977, 22850.31449056531, 2310.306907927615, 2313.90744370225, 2522.230719630512, 2714.429969706364, 3026.6216722909635, 9568.66509672165, 9939.0, 10286.9485652572, 10443.686689399254, 13683.726325473534, 1828.168183476515, 1871.1112221694723, 1909.284018493065, 1911.8183772541586, 1989.4031790462802, 59684.701576492276, 76659.41757280283, 76849.61575192088, 78802.0, 80060.39577229596, 10366.378017318984, 10477.84283235752, 10498.370097794157, 11490.712732181762, 11495.942520287344, 13950.23273719955, 14580.562583122522, 14658.853411465749, 14716.484923027856, 14742.852571474363, 7275.0, 7354.705811767576, 7485.288897554724, 7522.511036782592, 7636.045494313211, 6890.414314783299, 6917.446604271646, 7123.180834204029, 7126.643667816588, 7159.105111861018, 4363.912721745547, 4464.330350447394, 4483.887902802391, 4587.619670571427, 4680.67235293533, 1828.8368199168885, 1907.9046047697836, 1919.0021188981652, 1931.2468137426415, 1945.299692110839, 886.5877367024235, 896.6099746610246, 913.3287034029983, 970.4759429907771, 997.2520609542843, 17247.396341128002, 18543.258269669062, 19514.5121371964, 19778.802211977694, 19896.303629373193, 953.2897990996752, 953.726774755695, 990.6235630460379, 1022.9897701023043, 1035.35807799165, 8076.676932922617, 10503.579856805794, 10919.508622112024, 10936.617218397318, 10958.890411095947, 388013.0, 441649.0, 442327.0, 452760.0, 454819.0, 82688.58655706682, 83490.26428371498, 85120.57439712886, 85879.57060214659, 86625.56687216523, 971.6356366362614, 981.8281800684852, 986.8322385194534, 993.99606397539, 1000.8899021107673, 15901.443449479213, 15953.04281743099, 16476.704659068473, 16555.420560280334, 16732.498025059267, 39352.40971385374, 39701.80149099236, 40112.799436002635, 40250.0, 40496.0, 50779.69931954411, 53959.73020134874, 54424.72787636037, 55121.44878551163, 59853.0, 7775.717006693832, 7907.0739645852855, 8034.47775894565, 8105.067917189599, 8328.167183281623, 11265.887341126483, 12504.312262825631, 12818.423170957143, 12856.059517141864, 12866.742665146832, 10629.202809789142, 10819.296745711503, 10823.417325804065, 10881.782364352826, 11171.484675995864, 10363.119134873621, 11001.889981100407, 11083.503726997074, 11603.361815099914, 11706.180567360203, 10843.891561084289, 11095.278806877526, 11118.110551156049, 11134.27627204229, 11444.599439019594, 7817.413693973089, 7998.160193179632, 8089.191080891864, 8132.959335203286, 8435.156484351515, 9662.0, 10828.349789842507, 11007.669769906915, 11008.0, 11240.269382490113], "value": 8848.112606396999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.261382546512, 1426.4579459805275, 1460.5837336359136, 1558.9922050389746, 1743.8953662780227, 7955.284024437799, 8753.3872628916, 9160.038195989426, 9161.541922903853, 9420.858687119699, 9168.358214924958, 9225.0, 9249.861252081224, 9257.907420925789, 9260.212881905029, 2315.583195024895, 2319.2810228829035, 2344.5310937812505, 2345.835791494596, 2348.9177878774244, 2271.114265436481, 2287.645414960684, 2335.346103091137, 2348.8942997565064, 2354.482013956927, 2284.3603790938564, 2302.8503147295455, 2315.3632750993443, 2343.8828058597087, 2348.189874493297, 2280.05377768226, 2284.2233640562204, 2284.7601001894895, 2287.1080278691325, 2289.5878741826546, 2195.9121635134575, 2215.711957445522, 2221.622324204889, 2222.8999695013763, 2223.4324801015246, 8900.821983560292, 9020.8646870297, 9114.316426268057, 9117.042710515367, 9144.268458523302, 5285.286486324336, 5488.643238189505, 5492.505674489275, 5502.394736578973, 5505.366882808488, 3399.3711163434846, 3420.1791570023265, 3450.344434557426, 3507.8070706111153, 3510.596281427617, 1046.49768111307, 1078.1374900079904, 2047.2015913793632, 2102.1696429910253, 2129.542148438093, 12683.302418366986, 12707.745845083138, 12815.807762883564, 12838.550650727273, 12845.421956012002, 4218.873433796991, 4451.688381813242, 4504.436945381827, 4611.239145541015, 4636.420447444069, 9934.205263578897, 9951.751206219758, 9953.153981911619, 9956.900430995598, 9960.501974901226, 5309.946900531023, 5310.044192045469, 5311.840644780663, 5315.601329900195, 5320.866978325573, 4364.738115713068, 4490.3040028795585, 4788.640851936118, 4885.828995985124, 4976.527229913152, 3636.072801435617, 3671.173985853162, 3746.868859589901, 3804.6575808177395, 3879.86420475282, 1142.126273400849, 1150.810116330813, 1158.3976332307323, 1159.3217967489113, 1165.4871856383165, 755.9622018899033, 898.6315610599622, 909.9163015921155, 918.0544039639183, 938.3712912348743, 5975.492083172979, 6131.877362452726, 6245.687715614201, 6270.15352927349, 6577.605343679299, 925.6066171876926, 950.0736781637986, 961.9230461563199, 1005.4168582222294, 1008.495752123938, 3790.1851102013197, 3805.8858234253016, 3827.4116241759357, 3888.358420860583, 3932.9606703932595, 11112.16658750597, 11511.597094101666, 11532.0, 11668.241564298294, 11669.35818529972, 11486.0811135109, 11494.597689080842, 11530.88469115315, 11535.134864885167, 11536.307821530734, 7728.381729461629, 8473.49159050459, 8608.655653773903, 8619.0, 8621.439606425687, 6082.482988945812, 6135.202423684892, 6140.3245642978345, 6255.655938923221, 6297.118403423616, 10469.528871200966, 10476.109530689977, 10503.317284376491, 10506.264561480622, 10520.473976301308, 10295.17638588896, 10909.836352454879, 11005.724856878642, 11048.226624136234, 11056.613018544313, 7034.929650703428, 7265.782026539212, 7647.349975252166, 8054.556999364857, 8209.13804050566, 8486.660533578835, 8854.690085846965, 8873.556322183995, 8875.73372798817, 8878.73363799087, 7609.39124869998, 7747.92252077472, 7807.531548107132, 7861.1745766693675, 7870.409719271192, 7581.848363032819, 7671.156172821097, 7692.7692169235015, 7712.5758083305955, 7742.38060955111, 6965.164180298397, 7088.503804733826, 7089.361957423856, 7096.432285417051, 7100.218975912749, 4928.8767780805765, 4938.901221975612, 4980.178270585313, 4983.202687569971, 5198.324217851655, 4889.242167464049, 4917.164082105979, 5005.7997680092385, 5008.373953255843, 5150.253213283978], "value": 4703.031943918993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.13027651033497, 332.7753766207809, 337.93241351729654, 339.5280560021569, 346.2883773844748, 5280.815171468999, 5317.367902888076, 5328.46715328467, 5329.481097887103, 5390.73046347683, 5021.372328458942, 5050.853387310388, 5103.366922584774, 5164.896702065957, 5315.893682126365, 4099.97950010251, 4111.594717090506, 4113.56807535209, 4137.2552940470705, 4146.917061658765, 4079.6532294754834, 4120.629143377096, 4134.676903390916, 4147.087640719052, 4169.312063509517, 3759.342115129855, 3892.143728379752, 4012.057166565855, 4029.4285228760805, 4086.6117718816663, 4052.1490486997764, 4053.6554392876346, 4077.97961010196, 4078.8164532596106, 4109.815058322398, 3593.6047034826147, 3595.1012246938267, 3597.226596281812, 3602.2795440911923, 3613.241219343941, 4853.907870729093, 5106.183010718267, 5120.334356533664, 5136.486351364871, 5175.412293853074, 4653.6509761768, 4660.603848672867, 4682.6019788318035, 4694.389729335165, 4708.858734237979, 5487.917681234745, 5506.669599823983, 5508.14623733322, 5530.668159910419, 5532.917006244909, 3748.6063963283736, 3931.626495482953, 3962.7820469874146, 3966.3257246267917, 3978.761274323521, 5637.3517045539875, 5638.548916086703, 5671.0, 5675.063614503643, 5680.0, 4029.536603290659, 4032.455618491466, 4034.959650403517, 4039.555648878621, 4039.6566291864933, 3894.6689531389584, 4057.5739547347694, 4105.220008198433, 4121.1345617420075, 4122.42286079949, 4652.697574657636, 4667.696599721007, 4668.719876807402, 4705.482396936334, 4737.123632128068, 5472.945270547323, 5498.285222920995, 5505.403433004464, 5561.360443549043, 5582.637128586629, 1345.9596212113652, 1392.9860701392856, 1413.1591702936737, 1416.6175132714109, 1418.1491105336715, 894.4722613657973, 899.8470260055806, 905.805251870851, 916.9633214671338, 921.3228277216241, 4577.473590537131, 4627.745473998895, 4630.282306242538, 4691.319758634979, 4711.74085425298, 4520.706154099973, 4907.552272079745, 4925.359703238628, 4946.378419437704, 4966.9817687374, 4666.0402630895105, 4690.859274221711, 4698.345434829311, 4702.764861756898, 4721.575058244705, 2621.820180918556, 2639.0998481093584, 2654.7345265473687, 2656.6811982562217, 2672.4387878545335, 4790.640701947368, 5016.2224855147515, 5045.772940217699, 5091.974540127349, 5142.434332223453, 4865.537773911544, 4907.877303067452, 4927.852164435073, 4940.258961155855, 4992.450830408652, 4929.3345398371475, 5048.788290810253, 5082.771275292621, 5088.465711100355, 5137.023965446553, 4934.851954441372, 4940.949505954988, 4976.581674222829, 5010.273510341053, 5250.711210883438, 5609.551235901036, 5633.155026746021, 5651.660900345993, 5660.688662123623, 5685.687287199244, 5829.0, 5850.912236316543, 5874.853128671817, 5939.762409503572, 5943.851403714942, 3911.0, 4073.4297198391655, 4088.4480595120467, 4088.4684990950987, 4122.361034039729, 5394.757235924314, 5402.5677945763455, 5517.806876759294, 5525.254090697705, 5585.525230355465, 5388.434214407431, 5402.216678581663, 5407.648087978006, 5424.918626220689, 5454.290942177491, 5294.444083371344, 5487.835364939058, 5490.478404551562, 5510.0, 5515.338159420895, 5444.945550544444, 5455.972720136533, 5499.890002200013, 5508.862278443071, 5513.751881165277, 5475.370332411823, 5508.338999319947, 5514.6691198528215, 5518.779248830162, 5535.0, 5240.030594340059, 5383.434739352311, 5405.594580406407, 5423.0, 5428.83713488596], "value": 4071.335122107047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6662851773925, 781.1173374087281, 788.3929374381722, 811.5536454949776, 867.5705525764746, 15340.846591534082, 16415.507534773962, 16513.091779952098, 16523.669526609476, 16567.17164141791, 15239.390424383038, 16071.839281607181, 16149.596260093504, 16164.191790410461, 16231.107289099094, 817.6606708216098, 834.9582520873962, 837.3259526081501, 837.7905523619095, 838.2748922182299, 664.5049438168571, 697.0450482838519, 791.4103992525577, 821.4003777242586, 821.8931538899934, 871.904090550039, 873.6112429968666, 873.9868901966476, 874.0123660263893, 874.2306770042354, 864.3603733237422, 864.8400045991481, 864.9221570058662, 864.9740507784777, 865.2040123086744, 516.3803435876926, 534.3480953237045, 605.6063558686889, 629.2040568680577, 636.017353189319, 14814.925925370411, 14845.554633361016, 14866.108033518023, 14878.925605371904, 14900.850991490055, 13695.86304136956, 14258.857411425857, 14290.428382864673, 14392.712145757027, 14411.423543058265, 12203.816942745865, 12485.188462749893, 12515.749685006249, 12594.118411711184, 12671.2397256164, 4309.116631090619, 4383.473983122014, 4405.383246345515, 4568.5431456854385, 4570.154521413516, 60061.0, 74235.62882185608, 75473.62263188759, 76568.21772081024, 76868.0, 10873.644912056552, 10877.401742904058, 11100.426019581888, 11349.716257093638, 11502.827457588142, 20868.47828804292, 20888.58222835565, 20911.68632470514, 20917.163313467594, 20948.0, 7883.802904927308, 8169.42814003026, 8228.341732661373, 8293.21214484623, 8352.749417517483, 4625.976870115695, 4694.788734506956, 4714.717116972993, 4730.053989202104, 4919.827806026772, 3245.4482737934136, 3345.1135449106005, 3351.4135026370286, 3351.9664803352143, 3354.9329013419597, 605.4187979539691, 607.2348840460962, 615.2125279642065, 618.4835662222005, 634.1407392982535, 625.8623102917351, 632.8481164520574, 671.1442910289322, 671.1945665201778, 674.9032821664795, 8484.957575212084, 8710.346723995726, 8984.101589840964, 9215.0, 9297.070292970784, 528.1892295326655, 613.8404014956054, 668.5220067651555, 680.6562685843618, 691.3432239372515, 4340.348947657877, 4411.867643970686, 4434.201843668106, 4439.378487011821, 4509.909801803946, 112056.43971780252, 113709.0, 114616.42691786488, 115148.42425787984, 115687.42156289164, 76400.0, 103622.0, 104053.47973260237, 105898.47050764697, 106596.0, 49775.25337120018, 63054.369456305765, 72990.27009729834, 79182.20817791864, 80573.0, 8791.868121978303, 9120.45277283365, 9620.182284505896, 9660.178884794872, 9692.33762540735, 46153.538464614925, 46188.22423739479, 46628.7668561655, 46826.53173468222, 47708.0, 46917.765411172724, 49154.75422622864, 60311.0, 60874.08688869759, 66298.66850665715, 12720.618381448572, 12934.741305174031, 12951.0, 13317.733645326845, 13795.310234488035, 13642.658933526742, 13976.860231397555, 14098.718025639635, 14140.363683634056, 14392.496262631177, 13046.428321975223, 13324.666883327995, 13728.0, 13757.518486852912, 13878.306084695927, 13174.419069711696, 13220.548258934488, 13420.731585368043, 13511.121777084458, 13582.0, 12074.39628018613, 12147.817782733442, 12277.447514862031, 12298.642805069057, 12456.12807103494, 9868.111869931741, 10042.548085336324, 10191.612615734952, 10400.61785848662, 10649.254552181274, 10221.25365487978, 10996.670099897015, 11012.889871101506, 11020.0, 11067.169962252703], "value": 7323.016310732231, "unit": "score"}], "name": "dromaeo_css", "value": 7143.0198893615925, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 111.0, 112.0, 112.0, 113.0, 110.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 122.0, 163.0, 124.0, 126.0, 127.0, 123.0, 160.0, 129.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 115.0, 78.0, 77.0, 76.0, 76.0, 101.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 110.0, 83.0, 83.0, 84.0, 115.0, 83.0, 83.0, 125.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 83.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 52.0, 53.0, 62.0, 55.0, 53.0, 52.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 80.0, 80.0, 80.0, 79.0, 80.0, 79.0, 80.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 129.0, 140.0, 129.0, 140.0, 128.0, 145.0, 177.0, 135.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 164.0, 170.0, 167.0, 164.0, 166.0, 171.0, 171.0, 173.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1500.6000000000001, "alertThreshold": 2.0}]} 19:02:00 INFO - Return code: 0 19:02:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:02:00 INFO - # TBPL SUCCESS # 19:02:00 INFO - Running post-action listener: _resource_record_post_action 19:02:00 INFO - [mozharness: 2016-10-25 02:02:00.880236Z] Finished run-tests step (success) 19:02:00 INFO - Running post-run listener: _resource_record_post_run 19:02:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 396824576; Read time: 0; Write time: 815588 19:02:00 INFO - TinderboxPrint: CPU usage
13.2% 19:02:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:02:00 INFO - TinderboxPrint: I/O write bytes / time
396,824,576 / 815,588 19:02:00 INFO - TinderboxPrint: CPU idle
8,307.2 (86.8%) 19:02:00 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 19:02:00 INFO - TinderboxPrint: Swap in / out
0 / 0 19:02:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 106823680; Read time: 0; Write time: 265504 19:02:00 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288903168; Read time: 0; Write time: 549744 19:02:01 INFO - Running post-run listener: _upload_blobber_files 19:02:01 INFO - Blob upload gear active. 19:02:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:02:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:02:01 INFO - (blobuploader) - INFO - Open directory for files ... 19:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:04 INFO - (blobuploader) - INFO - Done attempting. 19:02:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:02:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:02:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:05 INFO - (blobuploader) - INFO - Done attempting. 19:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:02:06 INFO - (blobuploader) - INFO - Done attempting. 19:02:06 INFO - (blobuploader) - INFO - Iteration through files over. 19:02:06 INFO - Return code: 0 19:02:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:02:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:02:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def1b533ec936b4919d596c2e5ada904f95ae3ab941e003c31e499e94e98577b1dc13e85e21bc0d40240b3dbedb59af4c5fca8c07388f5b1615e2e96df088f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bb59a9884a6b7c15a2dc18a356f39c21a236010d9d220716edcff07b303e5f9d8c627c772767913dea1efb2bf82d380197b8a3dfb0c411daa79494cf445c4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e8c9e6ba2f596892eb36aee9fc65e805acaf2ca80c747598c9c24562a07f5c9239330890acffd44e5dcef0262cd73c3a55126b68f6c9f4abf5b7ebde2168c1"} 19:02:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:02:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:02:06 INFO - Contents: 19:02:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def1b533ec936b4919d596c2e5ada904f95ae3ab941e003c31e499e94e98577b1dc13e85e21bc0d40240b3dbedb59af4c5fca8c07388f5b1615e2e96df088f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bb59a9884a6b7c15a2dc18a356f39c21a236010d9d220716edcff07b303e5f9d8c627c772767913dea1efb2bf82d380197b8a3dfb0c411daa79494cf445c4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e8c9e6ba2f596892eb36aee9fc65e805acaf2ca80c747598c9c24562a07f5c9239330890acffd44e5dcef0262cd73c3a55126b68f6c9f4abf5b7ebde2168c1"} 19:02:06 INFO - Running post-run listener: copy_logs_to_upload_dir 19:02:06 INFO - Copying logs to upload dir... 19:02:06 INFO - mkdir: /builds/slave/test/build/upload/logs 19:02:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.572738 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-24 19:02:06.524184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:06.527740) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def1b533ec936b4919d596c2e5ada904f95ae3ab941e003c31e499e94e98577b1dc13e85e21bc0d40240b3dbedb59af4c5fca8c07388f5b1615e2e96df088f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bb59a9884a6b7c15a2dc18a356f39c21a236010d9d220716edcff07b303e5f9d8c627c772767913dea1efb2bf82d380197b8a3dfb0c411daa79494cf445c4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e8c9e6ba2f596892eb36aee9fc65e805acaf2ca80c747598c9c24562a07f5c9239330890acffd44e5dcef0262cd73c3a55126b68f6c9f4abf5b7ebde2168c1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477348234/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def1b533ec936b4919d596c2e5ada904f95ae3ab941e003c31e499e94e98577b1dc13e85e21bc0d40240b3dbedb59af4c5fca8c07388f5b1615e2e96df088f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4bb59a9884a6b7c15a2dc18a356f39c21a236010d9d220716edcff07b303e5f9d8c627c772767913dea1efb2bf82d380197b8a3dfb0c411daa79494cf445c4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6e8c9e6ba2f596892eb36aee9fc65e805acaf2ca80c747598c9c24562a07f5c9239330890acffd44e5dcef0262cd73c3a55126b68f6c9f4abf5b7ebde2168c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:06.553491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:06.553817) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1477359684.589534-218725927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 19:02:06.639180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:02:06.639523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 19:02:06.639828) ========= ========= Total master_lag: 0.17 =========