builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1475868887.76 results: success (0) buildid: 20161007093044 builduid: c19edd7aad704cd1898be75de37e774a revision: 4b037d0911096b355e762561e3d05f65d053baaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.761337) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.761855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.762188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.777009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.777368) ========= 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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 12:34:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-07 12:34:48 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.908252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.909046) ========= 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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.959830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:47.960263) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b037d0911096b355e762561e3d05f65d053baaa --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 4b037d0911096b355e762561e3d05f65d053baaa --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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 12:34:48,580 truncating revision to first 12 chars 2016-10-07 12:34:48,580 Setting DEBUG logging. 2016-10-07 12:34:48,580 attempt 1/10 2016-10-07 12:34:48,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b037d091109?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 12:34:48,888 unpacking tar archive at: fx-team-4b037d091109/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:48.691315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:48.692300) ========= script_repo_revision: 4b037d0911096b355e762561e3d05f65d053baaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:48.693431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:48.694252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 12:34:48.706039) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-07 12:34:48.706367) ========= /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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:49 INFO - MultiFileLogger online at 20161007 12:34:49 in /builds/slave/test 12:34:49 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 12:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:49 INFO - {'append_to_log': False, 12:34:49 INFO - 'base_work_dir': '/builds/slave/test', 12:34:49 INFO - 'blob_upload_branch': 'Fx-Team', 12:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:49 INFO - 'branch': 'Fx-Team', 12:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:49 INFO - 'config_files': ('talos/linux_config.py',), 12:34:49 INFO - 'default_actions': ('clobber', 12:34:49 INFO - 'read-buildbot-config', 12:34:49 INFO - 'download-and-extract', 12:34:49 INFO - 'populate-webroot', 12:34:49 INFO - 'create-virtualenv', 12:34:49 INFO - 'install', 12:34:49 INFO - 'run-tests'), 12:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:49 INFO - 'download_minidump_stackwalk': True, 12:34:49 INFO - 'download_symbols': 'ondemand', 12:34:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:49 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:49 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:49 INFO - 'installer_path': 'installer.exe', 12:34:49 INFO - 'log_level': 'info', 12:34:49 INFO - 'log_name': 'talos', 12:34:49 INFO - 'log_to_console': True, 12:34:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:49 INFO - 'opt_config_files': (), 12:34:49 INFO - 'pip_index': False, 12:34:49 INFO - 'sps_profile': False, 12:34:49 INFO - 'sps_profile_interval': 0, 12:34:49 INFO - 'suite': 'dromaeojs', 12:34:49 INFO - 'system_bits': '32', 12:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:49 INFO - 'title': 'talos-linux64-ix-008', 12:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:49 INFO - 'use_talos_json': True, 12:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:49 INFO - 'work_dir': 'build'} 12:34:49 INFO - [mozharness: 2016-10-07 19:34:49.425006Z] Running clobber step. 12:34:49 INFO - Running pre-action listener: _resource_record_pre_action 12:34:49 INFO - Running main action method: clobber 12:34:49 INFO - rmtree: /builds/slave/test/build 12:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:49 INFO - Running post-action listener: _resource_record_post_action 12:34:49 INFO - [mozharness: 2016-10-07 19:34:49.910274Z] Finished clobber step (success) 12:34:49 INFO - [mozharness: 2016-10-07 19:34:49.910376Z] Running read-buildbot-config step. 12:34:49 INFO - Running pre-action listener: _resource_record_pre_action 12:34:49 INFO - Running main action method: read_buildbot_config 12:34:49 INFO - Using buildbot properties: 12:34:49 INFO - { 12:34:49 INFO - "project": "", 12:34:49 INFO - "product": "firefox", 12:34:49 INFO - "script_repo_revision": "production", 12:34:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:34:49 INFO - "repository": "", 12:34:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:34:49 INFO - "buildid": "20161007093044", 12:34:49 INFO - "pgo_build": "True", 12:34:49 INFO - "basedir": "/builds/slave/test", 12:34:49 INFO - "buildnumber": 514, 12:34:49 INFO - "slavename": "talos-linux64-ix-008", 12:34:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:34:49 INFO - "platform": "ubuntu64_hw", 12:34:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:34:49 INFO - "branch": "fx-team", 12:34:49 INFO - "repo_path": "integration/fx-team", 12:34:49 INFO - "revision": "4b037d0911096b355e762561e3d05f65d053baaa", 12:34:49 INFO - "stage_platform": "linux64-pgo", 12:34:49 INFO - "builduid": "c19edd7aad704cd1898be75de37e774a", 12:34:49 INFO - "slavebuilddir": "test" 12:34:49 INFO - } 12:34:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:34:49 INFO - Running post-action listener: _resource_record_post_action 12:34:49 INFO - [mozharness: 2016-10-07 19:34:49.912794Z] Finished read-buildbot-config step (success) 12:34:49 INFO - [mozharness: 2016-10-07 19:34:49.912881Z] Running download-and-extract step. 12:34:49 INFO - Running pre-action listener: _resource_record_pre_action 12:34:49 INFO - Running main action method: download_and_extract 12:34:49 INFO - mkdir: /builds/slave/test/build/tests 12:34:49 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')]} 12:34:49 INFO - trying https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:34:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/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 12:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/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 12:34:50 INFO - Downloaded 1361 bytes. 12:34:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:34:50 INFO - Using the following test package requirements: 12:34:50 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:34:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:34:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'jsshell-linux-x86_64.zip'], 12:34:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:34:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:34:50 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:34:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:34:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:34:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:34:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:34:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:51 INFO - Http code: 200 12:34:51 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 12:34:51 INFO - x-amz-cf-id: uBgodCPl8CawFn5qi0E_QIh0SPHIOr1N5jtsfyFcYF1zfWEH84r0gg== 12:34:51 INFO - x-amz-version-id: W_rDEmc1uSqPdpbeTgLqjuMvlHUmysE7 12:34:51 INFO - Expected file size: 22038304 12:34:51 INFO - Obtained file size: 22038304 12:34:55 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 12:34:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:34:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:34:55 INFO - Http code: 200 12:34:55 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 12:34:55 INFO - x-amz-cf-id: lrOffjEvM43aCjN2JVUuV-9wppXUg7cyf0iytFkpoJ2r8UfFu69bwQ== 12:34:55 INFO - x-amz-version-id: W_rDEmc1uSqPdpbeTgLqjuMvlHUmysE7 12:34:56 INFO - Expected file size: 22038304 12:34:56 INFO - Obtained file size: 22038304 12:35:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:35:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:35:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:35:01 INFO - Http code: 200 12:35:01 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 12:35:01 INFO - x-amz-cf-id: CvG4tqcneDyf44AFtbUpO-WuVaj6SmNArRrAmRIWa5Gs2lQBUh7uQw== 12:35:01 INFO - x-amz-version-id: 846YB0tKOyu1iC_F7LBw42eR4Zr.4vsg 12:35:02 INFO - Expected file size: 14409006 12:35:02 INFO - Obtained file size: 14409006 12:35:02 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')]} 12:35:02 INFO - trying https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:35:02 INFO - Downloading https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/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 12:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/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 12:35:03 INFO - Downloaded 59731465 bytes. 12:35:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:35:03 INFO - mkdir: /builds/slave/test/properties 12:35:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:35:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:35:03 INFO - Contents: 12:35:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:35:04 INFO - Running post-action listener: _resource_record_post_action 12:35:04 INFO - Running post-action listener: set_extra_try_arguments 12:35:04 INFO - [mozharness: 2016-10-07 19:35:04.168244Z] Finished download-and-extract step (success) 12:35:04 INFO - [mozharness: 2016-10-07 19:35:04.168472Z] Running populate-webroot step. 12:35:04 INFO - Running pre-action listener: _resource_record_pre_action 12:35:04 INFO - Running main action method: populate_webroot 12:35:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:35:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:35:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:35:04 INFO - '--tppagecycles', 12:35:04 INFO - '7'], 12:35:04 INFO - 'tests': ['tsvgm']}}, 12:35:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:35:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:35:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:35:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:35:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['damp', 'tps']}, 12:35:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'tests': ['damp', 'tps']}, 12:35:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['dromaeo_dom']}, 12:35:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:35:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['basic_compositor_video']}, 12:35:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:35:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'other-e10s': {'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['a11yr', 12:35:04 INFO - 'ts_paint', 12:35:04 INFO - 'tpaint', 12:35:04 INFO - 'sessionrestore', 12:35:04 INFO - 'sessionrestore_no_auto_restore', 12:35:04 INFO - 'tabpaint']}, 12:35:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['tsvgx', 12:35:04 INFO - 'tsvgr_opacity', 12:35:04 INFO - 'tart', 12:35:04 INFO - 'tscrollx', 12:35:04 INFO - 'cart']}, 12:35:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:35:04 INFO - 'tsvgr_opacity', 12:35:04 INFO - 'tart', 12:35:04 INFO - 'tscrollx', 12:35:04 INFO - 'cart']}, 12:35:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'talos_options': ['--disable-e10s'], 12:35:04 INFO - 'tests': ['tp5o']}, 12:35:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'tests': ['tp5o']}, 12:35:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'talos_options': ['--disable-e10s', 12:35:04 INFO - '--xperf_path', 12:35:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:04 INFO - 'tests': ['tp5n']}, 12:35:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:04 INFO - 'talos_options': ['--xperf_path', 12:35:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:04 INFO - 'tests': ['tp5n']}}, 12:35:04 INFO - 'talos.zip': {'path': '', 12:35:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:35:04 INFO - Running post-action listener: _resource_record_post_action 12:35:04 INFO - [mozharness: 2016-10-07 19:35:04.190475Z] Finished populate-webroot step (success) 12:35:04 INFO - [mozharness: 2016-10-07 19:35:04.190563Z] Running create-virtualenv step. 12:35:04 INFO - Running pre-action listener: _resource_record_pre_action 12:35:04 INFO - Running main action method: create_virtualenv 12:35:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:35:04 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 12:35:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:35:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:35:04 INFO - Using real prefix '/usr' 12:35:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:35:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:35:06 INFO - Installing pip.................done. 12:35:06 INFO - Return code: 0 12:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:35:06 INFO - Reading from file tmpfile_stdout 12:35:06 INFO - Output received: 12:35:06 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) 12:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:35:06 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')]} 12:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:06 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')]} 12:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:07 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:07 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 12:35:07 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 12:35:07 INFO - Using env: {'DISPLAY': ':0', 12:35:07 INFO - 'HOME': '/home/cltbld', 12:35:07 INFO - 'LANG': 'en_US.UTF-8', 12:35:07 INFO - 'LANGUAGE': 'en_US:en', 12:35:07 INFO - 'LOGNAME': 'cltbld', 12:35:07 INFO - 'MAIL': '/var/mail/cltbld', 12:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:07 INFO - 'MOZ_NO_REMOTE': '1', 12:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:07 INFO - 'NO_EM_RESTART': '1', 12:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:07 INFO - 'PWD': '/builds/slave/test', 12:35:07 INFO - 'SHELL': '/bin/bash', 12:35:07 INFO - 'SHLVL': '1', 12:35:07 INFO - 'TERM': 'linux', 12:35:07 INFO - 'TMOUT': '86400', 12:35:07 INFO - 'USER': 'cltbld', 12:35:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:07 INFO - '_': '/tools/buildbot/bin/python'} 12:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:07 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 12:35:07 INFO - Cleaning up... 12:35:07 INFO - Return code: 0 12:35:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:35:07 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')]} 12:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:07 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')]} 12:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:07 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:07 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 12:35:07 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 12:35:07 INFO - Using env: {'DISPLAY': ':0', 12:35:07 INFO - 'HOME': '/home/cltbld', 12:35:07 INFO - 'LANG': 'en_US.UTF-8', 12:35:07 INFO - 'LANGUAGE': 'en_US:en', 12:35:07 INFO - 'LOGNAME': 'cltbld', 12:35:07 INFO - 'MAIL': '/var/mail/cltbld', 12:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:07 INFO - 'MOZ_NO_REMOTE': '1', 12:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:07 INFO - 'NO_EM_RESTART': '1', 12:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:07 INFO - 'PWD': '/builds/slave/test', 12:35:07 INFO - 'SHELL': '/bin/bash', 12:35:07 INFO - 'SHLVL': '1', 12:35:07 INFO - 'TERM': 'linux', 12:35:07 INFO - 'TMOUT': '86400', 12:35:07 INFO - 'USER': 'cltbld', 12:35:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:07 INFO - '_': '/tools/buildbot/bin/python'} 12:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:07 INFO - Downloading/unpacking psutil>=3.1.1 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:07 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 12:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:35:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:09 INFO - Installing collected packages: psutil 12:35:09 INFO - Running setup.py install for psutil 12:35:09 INFO - building 'psutil._psutil_linux' extension 12:35:09 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 12:35:09 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 12:35:09 INFO - building 'psutil._psutil_posix' extension 12:35:09 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 12:35:09 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 12:35:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:09 INFO - Successfully installed psutil 12:35:09 INFO - Cleaning up... 12:35:09 INFO - Return code: 0 12:35:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:35:09 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')]} 12:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 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')]} 12:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:10 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 12:35:10 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 12:35:10 INFO - Using env: {'DISPLAY': ':0', 12:35:10 INFO - 'HOME': '/home/cltbld', 12:35:10 INFO - 'LANG': 'en_US.UTF-8', 12:35:10 INFO - 'LANGUAGE': 'en_US:en', 12:35:10 INFO - 'LOGNAME': 'cltbld', 12:35:10 INFO - 'MAIL': '/var/mail/cltbld', 12:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:10 INFO - 'MOZ_NO_REMOTE': '1', 12:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:10 INFO - 'NO_EM_RESTART': '1', 12:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:10 INFO - 'PWD': '/builds/slave/test', 12:35:10 INFO - 'SHELL': '/bin/bash', 12:35:10 INFO - 'SHLVL': '1', 12:35:10 INFO - 'TERM': 'linux', 12:35:10 INFO - 'TMOUT': '86400', 12:35:10 INFO - 'USER': 'cltbld', 12:35:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:10 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:35:12 INFO - Installing collected packages: mozsystemmonitor 12:35:12 INFO - Running setup.py install for mozsystemmonitor 12:35:12 INFO - Successfully installed mozsystemmonitor 12:35:12 INFO - Cleaning up... 12:35:12 INFO - Return code: 0 12:35:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:35:12 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')]} 12:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 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')]} 12:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:12 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 12:35:12 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 12:35:12 INFO - Using env: {'DISPLAY': ':0', 12:35:12 INFO - 'HOME': '/home/cltbld', 12:35:12 INFO - 'LANG': 'en_US.UTF-8', 12:35:12 INFO - 'LANGUAGE': 'en_US:en', 12:35:12 INFO - 'LOGNAME': 'cltbld', 12:35:12 INFO - 'MAIL': '/var/mail/cltbld', 12:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:12 INFO - 'MOZ_NO_REMOTE': '1', 12:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:12 INFO - 'NO_EM_RESTART': '1', 12:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:12 INFO - 'PWD': '/builds/slave/test', 12:35:12 INFO - 'SHELL': '/bin/bash', 12:35:12 INFO - 'SHLVL': '1', 12:35:12 INFO - 'TERM': 'linux', 12:35:12 INFO - 'TMOUT': '86400', 12:35:12 INFO - 'USER': 'cltbld', 12:35:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:12 INFO - '_': '/tools/buildbot/bin/python'} 12:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:12 INFO - Downloading/unpacking jsonschema==2.5.1 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:12 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 12:35:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:35:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:35:14 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 12:35:14 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 12:35:14 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 12:35:14 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 12:35:14 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 12:35:14 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 12:35:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:35:14 INFO - warning: no files found matching '*.txt' 12:35:14 INFO - no previously-included directories found matching 'build' 12:35:14 INFO - no previously-included directories found matching 'dist' 12:35:14 INFO - no previously-included directories found matching '.git*' 12:35:14 INFO - Installing collected packages: jsonschema, functools32 12:35:14 INFO - Running setup.py install for functools32 12:35:14 INFO - warning: no files found matching '*.txt' 12:35:14 INFO - no previously-included directories found matching 'build' 12:35:14 INFO - no previously-included directories found matching 'dist' 12:35:14 INFO - no previously-included directories found matching '.git*' 12:35:14 INFO - Successfully installed jsonschema functools32 12:35:14 INFO - Cleaning up... 12:35:14 INFO - Return code: 0 12:35:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:35:14 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')]} 12:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:14 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')]} 12:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:14 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:14 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 12:35:14 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 12:35:14 INFO - Using env: {'DISPLAY': ':0', 12:35:14 INFO - 'HOME': '/home/cltbld', 12:35:14 INFO - 'LANG': 'en_US.UTF-8', 12:35:14 INFO - 'LANGUAGE': 'en_US:en', 12:35:14 INFO - 'LOGNAME': 'cltbld', 12:35:14 INFO - 'MAIL': '/var/mail/cltbld', 12:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:14 INFO - 'MOZ_NO_REMOTE': '1', 12:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:14 INFO - 'NO_EM_RESTART': '1', 12:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:14 INFO - 'PWD': '/builds/slave/test', 12:35:14 INFO - 'SHELL': '/bin/bash', 12:35:14 INFO - 'SHLVL': '1', 12:35:14 INFO - 'TERM': 'linux', 12:35:14 INFO - 'TMOUT': '86400', 12:35:14 INFO - 'USER': 'cltbld', 12:35:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:14 INFO - '_': '/tools/buildbot/bin/python'} 12:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:35:15 INFO - Cleaning up... 12:35:15 INFO - Return code: 0 12:35:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:35:15 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')]} 12:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:15 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')]} 12:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:15 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:15 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 12:35:15 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 12:35:15 INFO - Using env: {'DISPLAY': ':0', 12:35:15 INFO - 'HOME': '/home/cltbld', 12:35:15 INFO - 'LANG': 'en_US.UTF-8', 12:35:15 INFO - 'LANGUAGE': 'en_US:en', 12:35:15 INFO - 'LOGNAME': 'cltbld', 12:35:15 INFO - 'MAIL': '/var/mail/cltbld', 12:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:15 INFO - 'MOZ_NO_REMOTE': '1', 12:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:15 INFO - 'NO_EM_RESTART': '1', 12:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:15 INFO - 'PWD': '/builds/slave/test', 12:35:15 INFO - 'SHELL': '/bin/bash', 12:35:15 INFO - 'SHLVL': '1', 12:35:15 INFO - 'TERM': 'linux', 12:35:15 INFO - 'TMOUT': '86400', 12:35:15 INFO - 'USER': 'cltbld', 12:35:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:15 INFO - '_': '/tools/buildbot/bin/python'} 12:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:35:15 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 12:35:15 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 12:35:15 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 12:35:15 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 12:35:15 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 12:35:15 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 12:35:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 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 12:35:17 INFO - Downloading docopt-0.6.1.tar.gz 12:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:18 INFO - Running setup.py install for blobuploader 12:35:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:18 INFO - Running setup.py install for requests 12:35:18 INFO - Running setup.py install for docopt 12:35:18 INFO - Successfully installed blobuploader requests docopt 12:35:18 INFO - Cleaning up... 12:35:18 INFO - Return code: 0 12:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35: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')]} 12:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35: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')]} 12:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:18 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:18 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 12:35:18 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 12:35:18 INFO - Using env: {'DISPLAY': ':0', 12:35:18 INFO - 'HOME': '/home/cltbld', 12:35:18 INFO - 'LANG': 'en_US.UTF-8', 12:35:18 INFO - 'LANGUAGE': 'en_US:en', 12:35:18 INFO - 'LOGNAME': 'cltbld', 12:35:18 INFO - 'MAIL': '/var/mail/cltbld', 12:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:18 INFO - 'MOZ_NO_REMOTE': '1', 12:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:18 INFO - 'NO_EM_RESTART': '1', 12:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:18 INFO - 'PWD': '/builds/slave/test', 12:35:18 INFO - 'SHELL': '/bin/bash', 12:35:18 INFO - 'SHLVL': '1', 12:35:18 INFO - 'TERM': 'linux', 12:35:18 INFO - 'TMOUT': '86400', 12:35:18 INFO - 'USER': 'cltbld', 12:35:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:18 INFO - '_': '/tools/buildbot/bin/python'} 12:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:18 INFO - Running setup.py (path:/tmp/pip-Rxs0b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:18 INFO - Running setup.py (path:/tmp/pip-v9lstT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:18 INFO - Running setup.py (path:/tmp/pip-BNtNCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:19 INFO - Running setup.py (path:/tmp/pip-3RKUKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:19 INFO - Running setup.py (path:/tmp/pip-eQLwMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:19 INFO - Running setup.py (path:/tmp/pip-E75pka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:19 INFO - Running setup.py (path:/tmp/pip-CZJlmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:19 INFO - Running setup.py (path:/tmp/pip-4FJzwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:19 INFO - Running setup.py (path:/tmp/pip-MQqk82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:19 INFO - Running setup.py (path:/tmp/pip-_BKaD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:19 INFO - Running setup.py (path:/tmp/pip-dU13Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:19 INFO - Running setup.py (path:/tmp/pip-lyjiJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:19 INFO - Running setup.py (path:/tmp/pip-SMSBNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:19 INFO - Running setup.py (path:/tmp/pip-PKpiCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:19 INFO - Running setup.py (path:/tmp/pip-f67ig_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:19 INFO - Running setup.py (path:/tmp/pip-XUAo7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:19 INFO - Running setup.py (path:/tmp/pip-Ao76KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:20 INFO - Running setup.py install for manifestparser 12:35:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Running setup.py install for mozcrash 12:35:20 INFO - Running setup.py install for mozdebug 12:35:20 INFO - Running setup.py install for mozdevice 12:35:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Running setup.py install for mozfile 12:35:20 INFO - Running setup.py install for mozhttpd 12:35:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Running setup.py install for mozinfo 12:35:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Running setup.py install for mozInstall 12:35:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:20 INFO - Running setup.py install for mozleak 12:35:21 INFO - Running setup.py install for mozlog 12:35:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Running setup.py install for moznetwork 12:35:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Running setup.py install for mozprocess 12:35:21 INFO - Running setup.py install for mozprofile 12:35:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Running setup.py install for mozrunner 12:35:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Running setup.py install for mozscreenshot 12:35:21 INFO - Running setup.py install for moztest 12:35:21 INFO - Running setup.py install for mozversion 12:35:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:21 INFO - Cleaning up... 12:35:21 INFO - Return code: 0 12:35:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:21 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')]} 12:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:21 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')]} 12:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:21 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:21 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 12:35:21 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 12:35:21 INFO - Using env: {'DISPLAY': ':0', 12:35:21 INFO - 'HOME': '/home/cltbld', 12:35:21 INFO - 'LANG': 'en_US.UTF-8', 12:35:21 INFO - 'LANGUAGE': 'en_US:en', 12:35:21 INFO - 'LOGNAME': 'cltbld', 12:35:21 INFO - 'MAIL': '/var/mail/cltbld', 12:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:21 INFO - 'MOZ_NO_REMOTE': '1', 12:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:21 INFO - 'NO_EM_RESTART': '1', 12:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:21 INFO - 'PWD': '/builds/slave/test', 12:35:21 INFO - 'SHELL': '/bin/bash', 12:35:21 INFO - 'SHLVL': '1', 12:35:21 INFO - 'TERM': 'linux', 12:35:21 INFO - 'TMOUT': '86400', 12:35:21 INFO - 'USER': 'cltbld', 12:35:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:21 INFO - '_': '/tools/buildbot/bin/python'} 12:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:22 INFO - Running setup.py (path:/tmp/pip-8VuOKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:22 INFO - Running setup.py (path:/tmp/pip-uNKie3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:22 INFO - Running setup.py (path:/tmp/pip-GrhB72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:22 INFO - Running setup.py (path:/tmp/pip-KpxK0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:22 INFO - Running setup.py (path:/tmp/pip-Sb8_oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:22 INFO - Running setup.py (path:/tmp/pip-xJAscD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:22 INFO - Running setup.py (path:/tmp/pip-3ypHQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:22 INFO - Running setup.py (path:/tmp/pip-ooaqfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:22 INFO - Running setup.py (path:/tmp/pip-8dSltt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:22 INFO - Running setup.py (path:/tmp/pip-CGPdt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:22 INFO - Running setup.py (path:/tmp/pip-neh2BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:22 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)) 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:22 INFO - Running setup.py (path:/tmp/pip-HJ756s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:23 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)) 12:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:23 INFO - Running setup.py (path:/tmp/pip-Sm6qzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:23 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)) 12:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:23 INFO - Running setup.py (path:/tmp/pip-sVCkA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:23 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)) 12:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:23 INFO - Running setup.py (path:/tmp/pip-YdLXKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:23 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)) 12:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:23 INFO - Running setup.py (path:/tmp/pip-PixxTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:23 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)) 12:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:23 INFO - Running setup.py (path:/tmp/pip-3iZ_yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:23 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)) 12:35:23 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)) 12:35:23 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)) 12:35:23 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)) 12:35:23 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)) 12:35:23 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)) 12:35:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:23 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 12:35:25 INFO - Downloading blessings-1.6.tar.gz 12:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:25 INFO - Installing collected packages: blessings 12:35:25 INFO - Running setup.py install for blessings 12:35:25 INFO - Successfully installed blessings 12:35:25 INFO - Cleaning up... 12:35:25 INFO - Return code: 0 12:35:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:25 INFO - Reading from file tmpfile_stdout 12:35:25 INFO - Current package versions: 12:35:25 INFO - argparse == 1.2.1 12:35:25 INFO - blessings == 1.6 12:35:25 INFO - blobuploader == 1.2.4 12:35:25 INFO - docopt == 0.6.1 12:35:25 INFO - functools32 == 3.2.3-2 12:35:25 INFO - jsonschema == 2.5.1 12:35:25 INFO - manifestparser == 1.1 12:35:25 INFO - mozInstall == 1.12 12:35:25 INFO - mozcrash == 0.17 12:35:25 INFO - mozdebug == 0.1 12:35:25 INFO - mozdevice == 0.48 12:35:25 INFO - mozfile == 1.2 12:35:25 INFO - mozhttpd == 0.7 12:35:25 INFO - mozinfo == 0.9 12:35:25 INFO - mozleak == 0.1 12:35:25 INFO - mozlog == 3.4 12:35:25 INFO - moznetwork == 0.27 12:35:25 INFO - mozprocess == 0.23 12:35:25 INFO - mozprofile == 0.28 12:35:25 INFO - mozrunner == 6.12 12:35:25 INFO - mozscreenshot == 0.1 12:35:25 INFO - mozsystemmonitor == 0.3 12:35:25 INFO - moztest == 0.7 12:35:25 INFO - mozversion == 1.4 12:35:25 INFO - psutil == 3.1.1 12:35:25 INFO - requests == 1.2.3 12:35:25 INFO - wsgiref == 0.1.2 12:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:25 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')]} 12:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:25 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')]} 12:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:25 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:25 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 12:35:25 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 12:35:25 INFO - Using env: {'DISPLAY': ':0', 12:35:25 INFO - 'HOME': '/home/cltbld', 12:35:25 INFO - 'LANG': 'en_US.UTF-8', 12:35:25 INFO - 'LANGUAGE': 'en_US:en', 12:35:25 INFO - 'LOGNAME': 'cltbld', 12:35:25 INFO - 'MAIL': '/var/mail/cltbld', 12:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:25 INFO - 'MOZ_NO_REMOTE': '1', 12:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:25 INFO - 'NO_EM_RESTART': '1', 12:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:25 INFO - 'PWD': '/builds/slave/test', 12:35:25 INFO - 'SHELL': '/bin/bash', 12:35:25 INFO - 'SHLVL': '1', 12:35:25 INFO - 'TERM': 'linux', 12:35:25 INFO - 'TMOUT': '86400', 12:35:25 INFO - 'USER': 'cltbld', 12:35:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:25 INFO - '_': '/tools/buildbot/bin/python'} 12:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 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)) 12:35:25 INFO - Cleaning up... 12:35:25 INFO - Return code: 0 12:35:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:25 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')]} 12:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:25 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')]} 12:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:25 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 0x7f90c24a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abb790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, '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': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', '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 12:35:25 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 12:35:25 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 12:35:25 INFO - Using env: {'DISPLAY': ':0', 12:35:25 INFO - 'HOME': '/home/cltbld', 12:35:25 INFO - 'LANG': 'en_US.UTF-8', 12:35:25 INFO - 'LANGUAGE': 'en_US:en', 12:35:25 INFO - 'LOGNAME': 'cltbld', 12:35:25 INFO - 'MAIL': '/var/mail/cltbld', 12:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:25 INFO - 'MOZ_NO_REMOTE': '1', 12:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:25 INFO - 'NO_EM_RESTART': '1', 12:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:25 INFO - 'PWD': '/builds/slave/test', 12:35:25 INFO - 'SHELL': '/bin/bash', 12:35:25 INFO - 'SHLVL': '1', 12:35:25 INFO - 'TERM': 'linux', 12:35:25 INFO - 'TMOUT': '86400', 12:35:25 INFO - 'USER': 'cltbld', 12:35:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:25 INFO - '_': '/tools/buildbot/bin/python'} 12:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:26 INFO - Cleaning up... 12:35:26 INFO - Return code: 0 12:35:26 INFO - Running post-action listener: _resource_record_post_action 12:35:26 INFO - Running post-action listener: _start_resource_monitoring 12:35:26 INFO - Starting resource monitoring. 12:35:26 INFO - [mozharness: 2016-10-07 19:35:26.230742Z] Finished create-virtualenv step (success) 12:35:26 INFO - [mozharness: 2016-10-07 19:35:26.231254Z] Running install step. 12:35:26 INFO - Running pre-action listener: _resource_record_pre_action 12:35:26 INFO - Running main action method: install 12:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:26 INFO - Reading from file tmpfile_stdout 12:35:26 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:26 INFO - Reading from file tmpfile_stdout 12:35:26 INFO - Output received: 12:35:26 INFO - Usage: mozinstall [options] installer 12:35:26 INFO - Options: 12:35:26 INFO - -h, --help show this help message and exit 12:35:26 INFO - -d DEST, --destination=DEST 12:35:26 INFO - Directory to install application into. [default: 12:35:26 INFO - "/builds/slave/test"] 12:35:26 INFO - --app=APP Application being installed. [default: firefox] 12:35:26 INFO - mkdir: /builds/slave/test/build/application 12:35:26 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'] 12:35:26 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 12:35:43 INFO - Reading from file tmpfile_stdout 12:35:43 INFO - Output received: 12:35:43 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:43 INFO - Running post-action listener: _resource_record_post_action 12:35:43 INFO - [mozharness: 2016-10-07 19:35:43.550516Z] Finished install step (success) 12:35:43 INFO - [mozharness: 2016-10-07 19:35:43.550764Z] Running run-tests step. 12:35:43 INFO - Running pre-action listener: _resource_record_pre_action 12:35:43 INFO - Running main action method: run_tests 12:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:43 INFO - Python 2.7.3 12:35:43 INFO - Return code: 0 12:35:43 INFO - grabbing minidump binary from tooltool 12:35:43 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')]} 12:35:43 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 0x2ab8930>, '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 0x2ab9830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:43 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 12:35:43 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 12:35:43 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 12:35:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:43 INFO - Return code: 0 12:35:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:43 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://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:35:43 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://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 12:35:43 INFO - Using env: {'DISPLAY': ':0', 12:35:43 INFO - 'HOME': '/home/cltbld', 12:35:43 INFO - 'LANG': 'en_US.UTF-8', 12:35:43 INFO - 'LANGUAGE': 'en_US:en', 12:35:43 INFO - 'LOGNAME': 'cltbld', 12:35:43 INFO - 'MAIL': '/var/mail/cltbld', 12:35:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:43 INFO - 'MOZ_NO_REMOTE': '1', 12:35:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:43 INFO - 'NO_EM_RESTART': '1', 12:35:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:43 INFO - 'PWD': '/builds/slave/test', 12:35:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:43 INFO - 'SHELL': '/bin/bash', 12:35:43 INFO - 'SHLVL': '1', 12:35:43 INFO - 'TERM': 'linux', 12:35:43 INFO - 'TMOUT': '86400', 12:35:43 INFO - 'USER': 'cltbld', 12:35:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731', 12:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:43 INFO - '_': '/tools/buildbot/bin/python'} 12:35:43 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://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 12:35:43 INFO - mozversion application_buildid: 20161007093044 12:35:43 INFO - mozversion application_changeset: 4b037d0911096b355e762561e3d05f65d053baaa 12:35:43 INFO - mozversion application_display_name: Nightly 12:35:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:43 INFO - mozversion application_name: Firefox 12:35:43 INFO - mozversion application_remotingname: firefox 12:35:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:35:43 INFO - mozversion application_vendor: Mozilla 12:35:43 INFO - mozversion application_version: 52.0a1 12:35:43 INFO - mozversion platform_buildid: 20161007093044 12:35:43 INFO - mozversion platform_changeset: 4b037d0911096b355e762561e3d05f65d053baaa 12:35:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:35:43 INFO - mozversion platform_version: 52.0a1 12:35:43 INFO - using testdate: 1475868943 12:35:43 INFO - actual date: 1475868943 12:35:43 INFO - starting webserver on 'localhost:49705' 12:35:43 INFO - SUITE-START | Running 2 tests 12:35:43 INFO - TEST-START | dromaeo_css 12:35:43 INFO - operating with platform_type : linux_ 12:35:43 INFO - Initialising browser for dromaeo_css test... 12:35:43 INFO - TEST-INFO | started process 15382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4LBlW/profile http://localhost:49705/getInfo.html) 12:35:48 INFO - PROCESS | 15382 | __metrics Screen width/height:1600/1200 12:35:48 INFO - PROCESS | 15382 | colorDepth:24 12:35:48 INFO - PROCESS | 15382 | Browser inner width/height: 1024/697 12:35:48 INFO - PROCESS | 15382 | __metrics 12:35:48 INFO - PROCESS | 15382 | 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" 12:35:48 INFO - PROCESS | 15382 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:49 INFO - PROCESS | 15382 | console.error: PushService: 12:35:49 INFO - PROCESS | 15382 | stateChangeProcessEnqueue: Error transitioning state 12:35:49 INFO - PROCESS | 15382 | UnknownError 12:35:49 INFO - TEST-INFO | 15382: exit 0 12:35:49 INFO - Browser initialized. 12:35:49 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:49 INFO - TEST-INFO | started process 15467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc4LBlW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:02 INFO - PROCESS | 15467 | RSS: Main: 172920832 12:36:02 INFO - PROCESS | 15467 | 12:36:53 INFO - PROCESS | 15467 | 1475869013610 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] 12:39:04 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49705/tests/dromaeo/cssquery-ext.html) 12:39:05 INFO - PROCESS | 15467 | RSS: Main: 304873472 12:39:05 INFO - PROCESS | 15467 | 12:42:08 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-ext.html (next: http://localhost:49705/tests/dromaeo/cssquery-jquery.html) 12:42:08 INFO - PROCESS | 15467 | RSS: Main: 275058688 12:42:08 INFO - PROCESS | 15467 | 12:45:10 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49705/tests/dromaeo/cssquery-mootools.html) 12:45:11 INFO - PROCESS | 15467 | RSS: Main: 216276992 12:45:11 INFO - PROCESS | 15467 | 12:48:13 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49705/tests/dromaeo/cssquery-prototype.html) 12:48:14 INFO - PROCESS | 15467 | RSS: Main: 259342336 12:48:14 INFO - PROCESS | 15467 | 12:51:16 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49705/tests/dromaeo/cssquery-yui.html) 12:51:17 INFO - PROCESS | 15467 | RSS: Main: 216846336 12:51:17 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-yui.html (next: http://localhost:49705/tests/dromaeo/cssquery-dojo.html) 12:54:20 INFO - PROCESS | 15467 | RSS: Main: 302612480 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | __start_tp_report 12:54:20 INFO - PROCESS | 15467 | _x_x_mozilla_page_load 12:54:20 INFO - PROCESS | 15467 | _x_x_mozilla_page_load_details 12:54:20 INFO - PROCESS | 15467 | |i|pagename|runs| 12:54:20 INFO - PROCESS | 15467 | |0;dojo.html;2994.7604191664664;3032.3783624357025;3033.3175035616982;3062.877484900604;3077.169164325632;5056.241563765437;5103.795848166078;5217.817376391827;5306.257124002638;5335.066363386406;5216.191490319006;5235.607329450297;5261.526462618363;5309.62832601718;5358.678479291245;4759.214729569617;4771.093492236464;4777.570018698317;4778.474367819555;4910.828121015765;4918.139325618021;4940.2342636891335;4950.331705219804;4954.529319714639;4980.651354405193;4690.718556886598;4730.432348118214;4735.147673418784;4884.5603895649565;4937.382827146606;4784.856454306377;4828.396450443694;4834.154023045988;4843.733594652293;4894.2658601210105;4751.691140075918;4773.474917759044;4780.832670856504;4798.304245884362;4811.206150985084;5115.795368185268;5272.024675435018;5282.102042652758;5283.894322113536;5355.143177091685;5486.149646804712;5575.972120139373;5579.637323573996;5584.329880414336;5588.189712491666;5602.691851948182;5604.131359639263;5614.6631202128;5620.325560932714;5624.15637654351;5198.584113270929;5242.239875218072;5253.264542964026;5257.973710131501;5258.92111618326;5674.631148975303;5720.713964301768;5723.513501352349;5724.942750572524;5725.77096916127;5538.307711536058;5562.471565201299;5565;5644.6330988485615;5656.85857853557;5663.207150998864;5665.065264231355;5669.914951275734;5725.656460612377;5733.455321744427;5622.522085622686;5635.915461268084;5636.661800291996;5637.069883469264;5637.23897273871;5468.398476167618;5514.751836167382;5663.377028526858;5665.3768085510565;5668.546516278688;4318.805653745589;4354.6951713380395;4356.128774245164;4362.956370436318;4408.074304396048;3843.1160833008566;3913.25648126855;3915.236528876899;3962.4650672159464;3967;5374.381946076173;5377.892442151135;5384.811531596375;5388.08402571556;5389.595780316492;5509.283793106871;5546.223528705985;5633.57748168889;5675.290588676416;5698.059820129715;5328.6802791832615;5330.040592693353;5332.760025798849;5350.678959262456;5352.598555108382;4759.309900064541;4921.876953076202;4941.703497790144;4943.876403089952;5000.049990501793;5720.856978575485;5830.650160990354;5876.588638795243;5912.70436478183;5985.640861548147;5730.598858079894;5737.254156959569;5739.684317362585;5744.569157313134;5746.913796293143;5913.46778789911;5924.822255332347;5930.584859059824;5932.2584676915385;5935.961206788881;5422.403535611001;5462.481064299044;5499.670019798825;5506.862328441821;5538.446155384429;5623.465770751772;5636.351819540805;5643.209950607001;5643.407442218508;5676.631018983753;5400.594955378441;5415.972920135374;5433.157860531624;5457.0995785696505;5476.945230547643;5302.098643230583;5374.140137577969;5386.676799392049;5440.972795135999;5516.255305533701;5500.4499550044675;5510.090835012178;5527.226188333556;5545.694986775766;5566.972165139148;5554.638948468337;5556.805511807067;5559.8888022240135;5565.415631358649;5566.944330556643;5280.339957505312;5333.386660534088;5413.756380962787;5456.372517160418;5528.7235638218735 12:54:20 INFO - PROCESS | 15467 | |1;ext.html;561.1834780394527;600.6486205569742;605.9606125601838;614.4531367083293;617.2531237202985;31074.223144421372;42745.572544274546;43402.782986085105;43495.78252108743;46445.53554464455;43130.35304470428;43668;43745.78127109368;43773.562264377346;43778.12443751123;8830.823383532326;8882.555872206396;9019.684311049115;9028.593713282919;9028.8645670315;8699.739007829743;8793.076726943675;8796.340274479408;8800.603972821238;8803.911960880405;8858.911410885905;8911.643534258621;8919.777005574848;8924;8929.910700892973;8821.117888211193;8871.290296776242;8875;8876.511791851446;8882.777930551723;8567.571621418903;8637.827243455096;8640.39517233794;8646.870296945552;8647.524386158759;40915.386269205985;41184.1763164738;41247.7937610313;41248.90633202522;41274.79362603168;3570.5715314162208;3691.7231207659534;3758;3779.433085037239;3946.8026598669953;31248.8437557813;31548.36903261922;31818.681813181804;32594.83702581472;33622.1594460138;4134.090500089976;4161.292580261363;4178.937315940263;4203.3064544350145;4218.535961044283;315402;317609;317829;318447;319386;56741;57187.14219286714;57190.7140464295;57241;57273.42726572681;59307.40692593105;59420;59420.70289648524;59444.70277648671;59468.405315946286;13314.600561983156;13623.18260904349;15915;16429.753553696704;16457.09485978283;12649.747005059848;12720.363981800872;12731.809022864665;12734.29961352116;12737.808932866015;16215.432459864083;16258.430954916757;16275.267612957445;16370.508884733477;16640.6671866562;5407.270018547524;6278.497720182374;6287.308396076428;6521.771737989147;6650.201975762842;930.9906900931039;1011.9038691324313;1028.2134167361974;1049.37037777333;1062.8565143705655;28891;29098.41803163925;29333.413331733245;29377.853110734737;29424.558631620544;1071.774927265283;1077.6928575355985;1080.6217823761779;1115.1914861725184;1156.3813359852438;15237.314320855367;16091.839081609034;16120.27458764335;16243.350265989227;16293.837061629232;475510;475597;478991;480468;480693;55277.06530271502;55366;55524.722376388665;55600.16599751007;55686;1082.7888561730388;1277.9297138657464;1295.533607901136;1327.3031658379427;1349.1163288046346;27940.44119117647;30283.69716302897;30514.694853052075;30721.231969200948;31333.52999705052;48903;49644.75177624089;49648.751756240985;49662.25506617331;49669.75165124151;370525;372307;372937;374452;374869.7591168592;27168.592471113345;27434.72565274322;27769;28284.85857570699;40432.79783601063;42848.57151428571;46570.301445479025;46637.53362466468;47006;47328.763356183;38136.618633813305;39613.40579891246;40173.59826401698;40345.798271008454;41517.37723934083;39698.80150599228;40030.1993960125;40517.797411012754;40531.79734101311;41958;39388.21223575455;39442.211155777295;40045;40222;40251.396229056;34197.65802341945;36002.45996310005;36058.27883442369;36509.45235821518;36849.63150368462;25044.373890652878;25142;25530.489390211722;25549.23352299434;25567.488650227264 12:54:20 INFO - PROCESS | 15467 | |2;jquery.html;382.89853188904965;393.9094008378073;410.65299821650706;412.2311888328268;428.4686988134714;13489.527866524673;15424.691506169884;18833;18946.336878209266;19625.50936226595;17995.19021644026;18202.271909123618;18501.44495665129;18522;18832.34086806962;4889.437714662806;5493.642913210639;5732.7133643317875;5735.053716136832;5735.655860648374;5595;5671.319441667006;5699.914501282484;5702.059160238556;5702.914456283159;5453.2092846537225;5616.9157462638095;5669.177969194464;5673.092305231164;5675.404082571333;5630.268065151525;5650.29371328584;5669.072515344803;5676.744546495418;5679.148127780824;4876.463589005207;5038.949610503922;5086.542211200973;5087.847364579068;5095.617828662828;22987.54024919492;23120.190793322323;23164.18925337622;23164.42088947773;23400.297991060295;2331.370529956919;2399.1722855614785;2467.5558399488086;2543.910963116282;2856.228818219069;14093.78859317111;14234;14461.71076578473;14830.851691483054;14861.554153375417;1896.2415033986515;1912.3880358285355;1954.9609007819906;1959.1575622482326;1972.7731310899287;78667;80215;80302;80797.59601201957;81052.59473702652;9940.602375904882;9974.800503990025;10325.690229293134;10490.685279441628;10604;13955.58133256004;13957.79063314051;13957.930210348883;13958.58124256274;13963.371648275852;7286.70853165878;7516.323530882247;7528.322450979329;7659.770206893691;7811.921880781233;7060;7127.679254433563;7272.527285726411;7294.9270507295305;7391.1500177480275;6184.752609895554;6409.455196308273;6492.837679058061;6529.804105876831;6539.6403197824575;1891.3663922585813;1942.1648691062978;1947.3963071447897;1971.6648169811167;2027.3208475160986;890.4523717913437;961.2166084640995;1001.0890090018048;1042.2339580408393;1077.5797438998798;17639.118044097744;18312.725309120375;18419.53951151232;18533.737240434504;18589.44231673052;976.472704739447;979.3487330924997;982;985.7683444390562;1012.291396022787;9960.950195248977;10509.31689440184;10787.514561844735;10808.567657293777;10818.837717434244;444047;463500;481136;483436;490192;87608.56195718981;90831.95641495132;92276;92637.5368123155;93965.5301723487;1026.414943482208;1034.2450011491653;1070.0904231403244;1076.924615276923;1077.3858900426837;16070.517884463485;16459;16721.665566688356;16857.409990650267;17095.91452042732;40491;41659.37510937399;41934.790326048176;42243.3663495054;42273.15453690971;57176;58857;59168.408315918015;59216.22351329467;59225;7862.72480463181;8104.8784268237205;8194.426390152632;8278.420510564443;8316.501009939422;11738.823917641072;12360.629181124581;12615.36923153857;12756.362181890683;12845.807312890502;11043.282186657842;11197.776044478902;11271.380074095676;11422.143339249424;11721.882781172078;10918.181136414642;10992.340459572451;11171.329720216812;11218.102551796;11711.765764684487;10322.174226062047;10863.891361086287;11196.664100076685;11497.310161390344;11638.88361116412;7882.802929926797;7981.880271796043;8080.515169089874;8330;8368.372372071997;10221.182305415698;10604.257701960789;10815;10818.56725730962;10977.615783447542 12:54:20 INFO - PROCESS | 15467 | |3;mootools.html;1328.4686125549786;1447.7176950494654;1485.5914623478543;1573.1898072492668;1738.4350086221982;7732.961335193323;8775.990761062472;9031.277497800169;9031.819363612723;9264.305177111726;9082;9153.954230228856;9172.587233574488;9178.40340377875;9178.862317065232;2329.7204335479723;2348.4363752699314;2349.1543044503965;2350.518143780521;2363.444590521226;2260.6948062011666;2307.515421761432;2315.22439982606;2331.393837602219;2336.474293284006;2310.792028717415;2331.4870728439714;2336.2991102669216;2366.2607983132384;2369.5616310982523;2264.750877403484;2289.3589794857385;2295.8048565871836;2300.700908881843;2318.675385446039;2294.128231272123;2299.9310020699404;2315.6063469210276;2318.5131122464304;2326.895289711967;9074.319426043074;9125.406848554823;9125.680601178994;9131;9435.386699864486;5342.27879236302;5448.101063324547;5474.42518535556;5474.7810087596445;5488;3408.522806807049;3446.3968805458944;3511.122219445139;3533.4169861972746;3550.7336949728874;1145.507431804324;1152.112873087726;1162.4478372772949;1163.9825402618967;1167.2062997161927;12568.560100396442;12636.49454021838;12685.556005539855;12689.682757931125;12698.301593412358;4342.500612429548;4488.708233964782;4628.861134165981;4632.2356811126465;4649.930251046237;9517.714468565953;9519.619215231452;9524.238060955107;9527.952360238154;9532.046795320552;5338.572914166857;5342.011727830364;5347.385050719139;5348.064088784447;5349.893002139936;4180.853670121531;4269.423627810268;4804.615630749532;4885.95114048855;5015.949840501621;3758.2671379080816;3848.3457812171996;3859.517560304962;3929.685625149981;3937.0944682723134;1204.9457774400173;1206.957756478519;1208.8670246272902;1218.214251807579;1222.6087651951468;846.3609974469236;874.1870060843349;912.1106920752213;958.6453012385323;971.931964762474;6048.092786082035;6113.541484388688;6158.414950579688;6267.2792628847355;6626.503012274099;914.1361413464213;926.3515539122641;938.7090002099371;964.1130160252584;995.7012896131132;4019.9598004019585;4122.361034039729;4214;4246.596573325529;4248.87253382399;10975.615853445091;11457.427128643534;11460.828087578693;11484.827727584094;11491.77016459666;11395.943020284845;11397.145214108976;11399;11408.144389170846;11445.88554114465;8051.114377418479;8468.534230617252;8529.189726975927;8601.61292741828;8604.268637165786;6002.639841609517;6233.189685340877;6365.458935990493;6396.104545363746;6440.452561532322;10631.787364252517;10682.732931676459;10685.732856678645;10698.62554810578;10803.891961080288;10148.289619726549;10539.841902371318;10545.578176873147;10797.784044319227;10832.133429325477;6928.16861976566;7120.857582848417;7122.7507037253445;7795.57124358143;7937.365010799007;7778.105517865518;7938.642761075881;8695.434796738191;8827.558622069;9047.411918225294;7781.9610901945125;7785;7958.0848202455145;8027.59862006909;8148.144444833444;7719.652615632423;7811.843763124819;7837.373010159287;7865.252800983897;7883.211678832071;7147.64261786919;7269.963650181715;7271.091113610799;7271.41828653717;7271.709131634675;5212.9739351303;5239.554637855825;5271.499207575274;5286.101362768261;5503.229547863382;5309.177077552986;5311.150215965427;5335.946640533545;5415.458454154553;5564.10974244119 12:54:20 INFO - PROCESS | 15467 | |4;prototype.html;307.3024234986581;319.66594908320803;320.45682568047164;321.7892280556235;323.8494100243387;4993.400791904976;5164.9483505164935;5194.688318700876;5227.242049902762;5262.368515778103;4986.675866068703;5058.772355244014;5095.3885533736;5102.158143906251;5161.354830646169;4061.2283666103494;4065.3292206785845;4070.9796451017705;4071.124708187739;4075.9388609170887;3917.981324855544;4047.7368971016936;4080.8571699990507;4081.265372232997;4081.9183616327655;3993.161436098408;4001.559828418872;4010.598940105995;4013.4381186633896;4030.8186131624147;3995.2808494470983;3998.5001874765653;4006.077083000147;4009.7594144351433;4014.7189696721093;3542.875999340011;3548.449990251515;3549.236914063463;3550.7336949728874;3574.7855128692363;4815;4960.87597810054;4998.800047998076;5004.3994720633755;5009.574186194178;4555.157295900269;4556.521565235669;4579.335996280521;4579.335996280554;4581.4502259728715;5343.519083282523;5348.812791552277;5353.812616558402;5356.339534744203;5361.2226227197225;3787.5644300905474;3869.5743468218475;3892.9416058759143;3909.980450097731;3912.4131380292897;5544.445555444464;5552.861178470571;5576.498115169614;5580.19087232349;5582.162675598652;3951.130751234781;3966.4248683941246;3969.64273215412;3984.382420724792;4027.657649099801;3776.3957766757185;3971.4439978403047;4054.716169868081;4064.451299074587;4066.898327541776;4513.435820522434;4531.864044078617;4533.727976321431;4538.682292239511;4599.586037256596;5403.351597808288;5420.186971954238;5421.918671219935;5423.511883930465;5437.728113594305;1298.2275546050084;1317.8286822712987;1330.6207730796677;1343.1403901503045;1358.1579420759192;894.217559635319;912.8037471943564;916.8212198621205;923.5500264584538;927.6521304510809;5033.572146367526;5048.59611231108;5054.898902021939;5062;5066.442691304027;5435.804123092913;5436.565074794007;5437.401885792559;5445.618806683494;5453.481919217668;4916.123596897674;5037.5214354636255;5056.469070747592;5071.923921141186;5095.337606111182;2537.3656585853537;2574.819762616636;2579.780718638899;2584.831985920909;2589.8446093234465;4918.9508104919205;4960.627952903475;4965.478624744422;4989.80040798364;4992.326035985096;4632.97683511587;4938.493759403416;4943.047496238965;4949.208126699711;4953.25701144824;4908.226851828706;4955.776990035457;4964.354633897642;4965.82619608312;4984.750762461862;4839.830605928775;4841.419029716316;4843.539863712942;4847.770025788177;4855.684380515255;4492.528284530077;4759.42886853566;4793.161196790478;4810.350602668595;4824.421069471686;4959.628027897994;4992.552159873596;4995;5006.724630145377;5012.824551140692;3518.595361533354;3547.8935631931085;3553.9289214215055;3561.7862928223353;3566.8038257896064;4858.157977583153;4872.3909511311085;4887.731174785421;4912.778924948315;5204.427512973494;4682.906341873211;5307.256984022317;5365.812196573102;5371.516563509303;5412.864678383072;5348.117560602457;5351.598630102836;5374.973125134349;5395.973020134874;5402.891942161214;5247.2744351510855;5349.545288650508;5368.946310536845;5379.5965302603245;5380.43505431924;5401.702906340189;5410.75651595687;5413.729313534386;5423.159410291411;5426.565874729933;5277.28756617867;5278.577713782965;5287.788488460418;5299;5308.920366194433 12:54:20 INFO - PROCESS | 15467 | |5;yui.html;756.9432292578055;776.8019155115445;787.4094429178116;791.7664289034734;823.6952327638775;15166.696666066671;17034.318627254896;17064.829351706478;17066.829331706696;17080.572985675364;14515.782263266034;14598.708025839476;14599.343029563668;14614.48849290275;14626;778.9844203115935;806.4999700185864;808.5512540539997;809.2191035650596;809.5952023988006;796.4146352430987;798.4530596541359;801.1667865419956;801.2948605227392;801.4149670740363;827.9213474719892;832.9750107496754;833.3250067445358;833.9374546908975;835.5488036460304;829.4484168028254;829.7718127514921;830.2652152844746;831.098258389648;831.1522247307712;611.245112286326;611.3916652930362;611.7338957553478;611.9296280927706;612.2041346249857;13528.25594592297;13534.661633459144;13555.59333220005;13570.728585428335;13591.524296649668;12749.574004063772;13290.534831280858;13390.732185356335;13527.256000919946;13973.23147226902;11397.544098236061;11448.026917712004;11467.254628449124;11518.078553715683;11860;3796.2787070456525;3808.314503389389;3841.7310788244836;3946.1910308386714;4049.088954985134;48359.75820120912;54533;56085.71957140188;65574;77824.61087694582;11691;11786;11786.528538858349;12354.320512371905;12603;21756.020979055666;22227.22204722859;22240.666390004164;22248.66627000564;22275.443113922283;8582;8658.307335413152;8694.95652521746;8698.086700896441;8857.512836794038;4612.377329060601;4619.284010978304;4719.7404142772475;4731.33761273422;4747.786349614275;3548.8757893473603;3680.742348035665;3694.538182727159;3701.7408781385043;3709.221063576625;664.9700763465559;669.0866966590569;676.070403195606;698.2737952529312;701.2601705201062;607.3683369295971;638.2341190571333;743.3272888036336;753.4462170304821;760.5322726523259;9156.221721153777;9346.859797103049;9782.11960923506;9984.35101718386;10026.949865250774;642.3223499208286;726.8400951790597;733.7211859493358;743.5612988336907;750.7109762741384;4429.11417716458;4681.976590117028;4712.458067322234;4745.335653008581;4809.78355973982;69380;69786.65106674434;70044;93234;115330.27004594938;105585;105957.22556067661;109503.45248273866;112649;113843;91663.2992601679;92602.53698731598;93994.53002734942;94218.52890735502;94786.8862293398;9098;9129.406588571987;9134.908650913672;9252.49111298885;9281.443113413217;54304.72847635736;54763;55225.44774552203;56072;58238.708806455696;76992.23007770075;77751.2224877744;78424.60787696253;80991;83251;12372.319522425993;12573.295400946048;12837.486500539873;13038.348082596021;13067.281299528237;13770.449182033008;13855.653608659864;14052.718945620825;14530.346134423766;14693.853061469248;12057.879421205676;12167.513299468275;12732.936335318263;12735.745285094432;12975.675608109872;12713.491460341853;12884.677883052998;13018.934905325414;13057.08600397963;13181.736365272833;13871.79192312096;13883.861161388257;14105.435782568582;14218.431262749375;14837.851621483647;11047.226694131334;11254.549818007188;11304.604338848101;11415;11817.409129543317;11455.255408398427;11464.770704586028;11501.712457188638;11684.941575292069;11777.352245626573 12:54:20 INFO - PROCESS | 15467 | __end_tp_report 12:54:20 INFO - PROCESS | 15467 | __start_cc_report 12:54:20 INFO - PROCESS | 15467 | _x_x_mozilla_cycle_collect,1206 12:54:20 INFO - PROCESS | 15467 | __end_cc_report 12:54:20 INFO - PROCESS | 15467 | __startTimestamp1475870060584__endTimestamp 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | ------- Summary: start ------- 12:54:20 INFO - PROCESS | 15467 | Number of tests: 6 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#0] dojo.html Cycles:165 Average:5246.01 Median:5415.97 stddev:586.03 (10.8%) stddev-sans-first:560.58 12:54:20 INFO - PROCESS | 15467 | Values: 2994.8 3032.4 3033.3 3062.9 3077.2 5056.2 5103.8 5217.8 5306.3 5335.1 5216.2 5235.6 5261.5 5309.6 5358.7 4759.2 4771.1 4777.6 4778.5 4910.8 4918.1 4940.2 4950.3 4954.5 4980.7 4690.7 4730.4 4735.1 4884.6 4937.4 4784.9 4828.4 4834.2 4843.7 4894.3 4751.7 4773.5 4780.8 4798.3 4811.2 5115.8 5272.0 5282.1 5283.9 5355.1 5486.1 5576.0 5579.6 5584.3 5588.2 5602.7 5604.1 5614.7 5620.3 5624.2 5198.6 5242.2 5253.3 5258.0 5258.9 5674.6 5720.7 5723.5 5724.9 5725.8 5538.3 5562.5 5565.0 5644.6 5656.9 5663.2 5665.1 5669.9 5725.7 5733.5 5622.5 5635.9 5636.7 5637.1 5637.2 5468.4 5514.8 5663.4 5665.4 5668.5 4318.8 4354.7 4356.1 4363.0 4408.1 3843.1 3913.3 3915.2 3962.5 3967.0 5374.4 5377.9 5384.8 5388.1 5389.6 5509.3 5546.2 5633.6 5675.3 5698.1 5328.7 5330.0 5332.8 5350.7 5352.6 4759.3 4921.9 4941.7 4943.9 5000.0 5720.9 5830.7 5876.6 5912.7 5985.6 5730.6 5737.3 5739.7 5744.6 5746.9 5913.5 5924.8 5930.6 5932.3 5936.0 5422.4 5462.5 5499.7 5506.9 5538.4 5623.5 5636.4 5643.2 5643.4 5676.6 5400.6 5416.0 5433.2 5457.1 5476.9 5302.1 5374.1 5386.7 5441.0 5516.3 5500.4 5510.1 5527.2 5545.7 5567.0 5554.6 5556.8 5559.9 5565.4 5566.9 5280.3 5333.4 5413.8 5456.4 5528.7 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#1] ext.html Cycles:180 Average:55243.60 Median:40475.30 stddev:104459.99 (258.1%) stddev-sans-first:104672.34 12:54:20 INFO - PROCESS | 15467 | Values: 561.2 600.6 606.0 614.5 617.3 31074.2 42745.6 43402.8 43495.8 46445.5 43130.4 43668.0 43745.8 43773.6 43778.1 8830.8 8882.6 9019.7 9028.6 9028.9 8699.7 8793.1 8796.3 8800.6 8803.9 8858.9 8911.6 8919.8 8924.0 8929.9 8821.1 8871.3 8875.0 8876.5 8882.8 8567.6 8637.8 8640.4 8646.9 8647.5 40915.4 41184.2 41247.8 41248.9 41274.8 3570.6 3691.7 3758.0 3779.4 3946.8 31248.8 31548.4 31818.7 32594.8 33622.2 4134.1 4161.3 4178.9 4203.3 4218.5 315402.0 317609.0 317829.0 318447.0 319386.0 56741.0 57187.1 57190.7 57241.0 57273.4 59307.4 59420.0 59420.7 59444.7 59468.4 13314.6 13623.2 15915.0 16429.8 16457.1 12649.7 12720.4 12731.8 12734.3 12737.8 16215.4 16258.4 16275.3 16370.5 16640.7 5407.3 6278.5 6287.3 6521.8 6650.2 931.0 1011.9 1028.2 1049.4 1062.9 28891.0 29098.4 29333.4 29377.9 29424.6 1071.8 1077.7 1080.6 1115.2 1156.4 15237.3 16091.8 16120.3 16243.4 16293.8 475510.0 475597.0 478991.0 480468.0 480693.0 55277.1 55366.0 55524.7 55600.2 55686.0 1082.8 1277.9 1295.5 1327.3 1349.1 27940.4 30283.7 30514.7 30721.2 31333.5 48903.0 49644.8 49648.8 49662.3 49669.8 370525.0 372307.0 372937.0 374452.0 374869.8 27168.6 27434.7 27769.0 28284.9 40432.8 42848.6 46570.3 46637.5 47006.0 47328.8 38136.6 39613.4 40173.6 40345.8 41517.4 39698.8 40030.2 40517.8 40531.8 41958.0 39388.2 39442.2 40045.0 40222.0 40251.4 34197.7 36002.5 36058.3 36509.5 36849.6 25044.4 25142.0 25530.5 25549.2 25567.5 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#2] jquery.html Cycles:180 Average:28314.40 Median:1619.56 stddev:78060.88 (4819.9%) stddev-sans-first:78251.69 12:54:20 INFO - PROCESS | 15467 | Values: 382.9 393.9 410.7 412.2 428.5 13489.5 15424.7 18833.0 18946.3 19625.5 17995.2 18202.3 18501.4 18522.0 18832.3 4889.4 5493.6 5732.7 5735.1 5735.7 5595.0 5671.3 5699.9 5702.1 5702.9 5453.2 5616.9 5669.2 5673.1 5675.4 5630.3 5650.3 5669.1 5676.7 5679.1 4876.5 5038.9 5086.5 5087.8 5095.6 22987.5 23120.2 23164.2 23164.4 23400.3 2331.4 2399.2 2467.6 2543.9 2856.2 14093.8 14234.0 14461.7 14830.9 14861.6 1896.2 1912.4 1955.0 1959.2 1972.8 78667.0 80215.0 80302.0 80797.6 81052.6 9940.6 9974.8 10325.7 10490.7 10604.0 13955.6 13957.8 13957.9 13958.6 13963.4 7286.7 7516.3 7528.3 7659.8 7811.9 7060.0 7127.7 7272.5 7294.9 7391.2 6184.8 6409.5 6492.8 6529.8 6539.6 1891.4 1942.2 1947.4 1971.7 2027.3 890.5 961.2 1001.1 1042.2 1077.6 17639.1 18312.7 18419.5 18533.7 18589.4 976.5 979.3 982.0 985.8 1012.3 9961.0 10509.3 10787.5 10808.6 10818.8 444047.0 463500.0 481136.0 483436.0 490192.0 87608.6 90832.0 92276.0 92637.5 93965.5 1026.4 1034.2 1070.1 1076.9 1077.4 16070.5 16459.0 16721.7 16857.4 17095.9 40491.0 41659.4 41934.8 42243.4 42273.2 57176.0 58857.0 59168.4 59216.2 59225.0 7862.7 8104.9 8194.4 8278.4 8316.5 11738.8 12360.6 12615.4 12756.4 12845.8 11043.3 11197.8 11271.4 11422.1 11721.9 10918.2 10992.3 11171.3 11218.1 11711.8 10322.2 10863.9 11196.7 11497.3 11638.9 7882.8 7981.9 8080.5 8330.0 8368.4 10221.2 10604.3 10815.0 10818.6 10977.6 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#3] mootools.html Cycles:180 Average:5908.45 Median:5226.26 stddev:3402.66 (65.1%) stddev-sans-first:3394.80 12:54:20 INFO - PROCESS | 15467 | Values: 1328.5 1447.7 1485.6 1573.2 1738.4 7733.0 8776.0 9031.3 9031.8 9264.3 9082.0 9154.0 9172.6 9178.4 9178.9 2329.7 2348.4 2349.2 2350.5 2363.4 2260.7 2307.5 2315.2 2331.4 2336.5 2310.8 2331.5 2336.3 2366.3 2369.6 2264.8 2289.4 2295.8 2300.7 2318.7 2294.1 2299.9 2315.6 2318.5 2326.9 9074.3 9125.4 9125.7 9131.0 9435.4 5342.3 5448.1 5474.4 5474.8 5488.0 3408.5 3446.4 3511.1 3533.4 3550.7 1145.5 1152.1 1162.4 1164.0 1167.2 12568.6 12636.5 12685.6 12689.7 12698.3 4342.5 4488.7 4628.9 4632.2 4649.9 9517.7 9519.6 9524.2 9528.0 9532.0 5338.6 5342.0 5347.4 5348.1 5349.9 4180.9 4269.4 4804.6 4886.0 5015.9 3758.3 3848.3 3859.5 3929.7 3937.1 1204.9 1207.0 1208.9 1218.2 1222.6 846.4 874.2 912.1 958.6 971.9 6048.1 6113.5 6158.4 6267.3 6626.5 914.1 926.4 938.7 964.1 995.7 4020.0 4122.4 4214.0 4246.6 4248.9 10975.6 11457.4 11460.8 11484.8 11491.8 11395.9 11397.1 11399.0 11408.1 11445.9 8051.1 8468.5 8529.2 8601.6 8604.3 6002.6 6233.2 6365.5 6396.1 6440.5 10631.8 10682.7 10685.7 10698.6 10803.9 10148.3 10539.8 10545.6 10797.8 10832.1 6928.2 7120.9 7122.8 7795.6 7937.4 7778.1 7938.6 8695.4 8827.6 9047.4 7782.0 7785.0 7958.1 8027.6 8148.1 7719.7 7811.8 7837.4 7865.3 7883.2 7147.6 7270.0 7271.1 7271.4 7271.7 5213.0 5239.6 5271.5 5286.1 5503.2 5309.2 5311.2 5335.9 5415.5 5564.1 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#4] prototype.html Cycles:180 Average:4371.64 Median:4940.77 stddev:1263.37 (25.6%) stddev-sans-first:1229.53 12:54:20 INFO - PROCESS | 15467 | Values: 307.3 319.7 320.5 321.8 323.8 4993.4 5164.9 5194.7 5227.2 5262.4 4986.7 5058.8 5095.4 5102.2 5161.4 4061.2 4065.3 4071.0 4071.1 4075.9 3918.0 4047.7 4080.9 4081.3 4081.9 3993.2 4001.6 4010.6 4013.4 4030.8 3995.3 3998.5 4006.1 4009.8 4014.7 3542.9 3548.4 3549.2 3550.7 3574.8 4815.0 4960.9 4998.8 5004.4 5009.6 4555.2 4556.5 4579.3 4579.3 4581.5 5343.5 5348.8 5353.8 5356.3 5361.2 3787.6 3869.6 3892.9 3910.0 3912.4 5544.4 5552.9 5576.5 5580.2 5582.2 3951.1 3966.4 3969.6 3984.4 4027.7 3776.4 3971.4 4054.7 4064.5 4066.9 4513.4 4531.9 4533.7 4538.7 4599.6 5403.4 5420.2 5421.9 5423.5 5437.7 1298.2 1317.8 1330.6 1343.1 1358.2 894.2 912.8 916.8 923.6 927.7 5033.6 5048.6 5054.9 5062.0 5066.4 5435.8 5436.6 5437.4 5445.6 5453.5 4916.1 5037.5 5056.5 5071.9 5095.3 2537.4 2574.8 2579.8 2584.8 2589.8 4919.0 4960.6 4965.5 4989.8 4992.3 4633.0 4938.5 4943.0 4949.2 4953.3 4908.2 4955.8 4964.4 4965.8 4984.8 4839.8 4841.4 4843.5 4847.8 4855.7 4492.5 4759.4 4793.2 4810.4 4824.4 4959.6 4992.6 4995.0 5006.7 5012.8 3518.6 3547.9 3553.9 3561.8 3566.8 4858.2 4872.4 4887.7 4912.8 5204.4 4682.9 5307.3 5365.8 5371.5 5412.9 5348.1 5351.6 5375.0 5396.0 5402.9 5247.3 5349.5 5368.9 5379.6 5380.4 5401.7 5410.8 5413.7 5423.2 5426.6 5277.3 5278.6 5287.8 5299.0 5308.9 12:54:20 INFO - PROCESS | 15467 | 12:54:20 INFO - PROCESS | 15467 | [#5] yui.html Cycles:180 Average:20193.15 Median:4697.22 stddev:28791.88 (613.0%) stddev-sans-first:28835.66 12:54:20 INFO - PROCESS | 15467 | Values: 756.9 776.8 787.4 791.8 823.7 15166.7 17034.3 17064.8 17066.8 17080.6 14515.8 14598.7 14599.3 14614.5 14626.0 779.0 806.5 808.6 809.2 809.6 796.4 798.5 801.2 801.3 801.4 827.9 833.0 833.3 833.9 835.5 829.4 829.8 830.3 831.1 831.2 611.2 611.4 611.7 611.9 612.2 13528.3 13534.7 13555.6 13570.7 13591.5 12749.6 13290.5 13390.7 13527.3 13973.2 11397.5 11448.0 11467.3 11518.1 11860.0 3796.3 3808.3 3841.7 3946.2 4049.1 48359.8 54533.0 56085.7 65574.0 77824.6 11691.0 11786.0 11786.5 12354.3 12603.0 21756.0 22227.2 22240.7 22248.7 22275.4 8582.0 8658.3 8695.0 8698.1 8857.5 4612.4 4619.3 4719.7 4731.3 4747.8 3548.9 3680.7 3694.5 3701.7 3709.2 665.0 669.1 676.1 698.3 701.3 607.4 638.2 743.3 753.4 760.5 9156.2 9346.9 9782.1 9984.4 10026.9 642.3 726.8 733.7 743.6 750.7 4429.1 4682.0 4712.5 4745.3 4809.8 69380.0 69786.7 70044.0 93234.0 115330.3 105585.0 105957.2 109503.5 112649.0 113843.0 91663.3 92602.5 93994.5 94218.5 94786.9 9098.0 9129.4 9134.9 9252.5 9281.4 54304.7 54763.0 55225.4 56072.0 58238.7 76992.2 77751.2 78424.6 80991.0 83251.0 12372.3 12573.3 12837.5 13038.3 13067.3 13770.4 13855.7 14052.7 14530.3 14693.9 12057.9 12167.5 12732.9 12735.7 12975.7 12713.5 12884.7 13018.9 13057.1 13181.7 13871.8 13883.9 14105.4 14218.4 14837.9 11047.2 11254.5 11304.6 11415.0 11817.4 11455.3 11464.8 11501.7 11684.9 11777.4 12:54:20 INFO - PROCESS | 15467 | -------- Summary: end -------- 12:54:20 INFO - PROCESS | 15467 | 12:54:21 INFO - TEST-INFO | 15467: exit 0 12:54:21 INFO - TEST-OK | dromaeo_css | took 1117664ms 12:54:21 INFO - TEST-START | kraken 12:54:21 INFO - operating with platform_type : linux_ 12:54:21 INFO - Initialising browser for kraken test... 12:54:21 INFO - TEST-INFO | started process 15769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7Bb8G/profile http://localhost:49705/getInfo.html) 12:54:25 INFO - PROCESS | 15769 | __metrics Screen width/height:1600/1200 12:54:25 INFO - PROCESS | 15769 | colorDepth:24 12:54:25 INFO - PROCESS | 15769 | Browser inner width/height: 1024/697 12:54:25 INFO - PROCESS | 15769 | __metrics 12:54:26 INFO - PROCESS | 15769 | 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" 12:54:26 INFO - PROCESS | 15769 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:26 INFO - PROCESS | 15769 | console.error: PushService: 12:54:26 INFO - PROCESS | 15769 | stateChangeProcessEnqueue: Error transitioning state 12:54:26 INFO - PROCESS | 15769 | UnknownError 12:54:27 INFO - TEST-INFO | 15769: exit 0 12:54:27 INFO - Browser initialized. 12:54:27 INFO - Running cycle 1/1 for kraken test... 12:54:27 INFO - TEST-INFO | started process 15855 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7Bb8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:39 INFO - PROCESS | 15855 | RSS: Main: 172806144 12:54:39 INFO - PROCESS | 15855 | 12:54:42 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:42 INFO - PROCESS | 15855 | RSS: Main: 240668672 12:54:42 INFO - PROCESS | 15855 | 12:54:45 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-dft) 12:54:46 INFO - PROCESS | 15855 | RSS: Main: 216764416 12:54:46 INFO - PROCESS | 15855 | 12:54:49 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-fft) 12:54:49 INFO - PROCESS | 15855 | RSS: Main: 298217472 12:54:49 INFO - PROCESS | 15855 | 12:54:51 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-oscillator) 12:54:52 INFO - PROCESS | 15855 | RSS: Main: 206950400 12:54:52 INFO - PROCESS | 15855 | 12:54:54 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:55 INFO - PROCESS | 15855 | RSS: Main: 212201472 12:54:55 INFO - PROCESS | 15855 | 12:54:58 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:58 INFO - PROCESS | 15855 | RSS: Main: 248336384 12:54:58 INFO - PROCESS | 15855 | 12:55:02 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-desaturate) 12:55:02 INFO - PROCESS | 15855 | RSS: Main: 247377920 12:55:02 INFO - PROCESS | 15855 | 12:55:05 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49705/tests/kraken/driver.html?testName=json-parse-financial) 12:55:06 INFO - PROCESS | 15855 | RSS: Main: 247435264 12:55:06 INFO - PROCESS | 15855 | 12:55:07 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:55:08 INFO - PROCESS | 15855 | RSS: Main: 209580032 12:55:08 INFO - PROCESS | 15855 | 12:55:10 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:55:10 INFO - PROCESS | 15855 | RSS: Main: 217112576 12:55:10 INFO - PROCESS | 15855 | 12:55:12 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:13 INFO - PROCESS | 15855 | RSS: Main: 226525184 12:55:13 INFO - PROCESS | 15855 | 12:55:16 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:16 INFO - PROCESS | 15855 | RSS: Main: 230756352 12:55:16 INFO - PROCESS | 15855 | 12:55:19 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:20 INFO - PROCESS | 15855 | RSS: Main: 231948288 12:55:20 INFO - PROCESS | 15855 | 12:55:21 INFO - PROCESS | 15855 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49705/tests/kraken/driver.html?testName=ai-astar) 12:55:22 INFO - PROCESS | 15855 | RSS: Main: 283144192 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | __start_tp_report 12:55:22 INFO - PROCESS | 15855 | _x_x_mozilla_page_load 12:55:22 INFO - PROCESS | 15855 | _x_x_mozilla_page_load_details 12:55:22 INFO - PROCESS | 15855 | |i|pagename|runs| 12:55:22 INFO - PROCESS | 15855 | |0;ai-astar;108;112;111;111;110;111;110;113;111;111 12:55:22 INFO - PROCESS | 15855 | |1;audio-beat-detection;149;121;123;156;122;125;124;123;162;128 12:55:22 INFO - PROCESS | 15855 | |2;audio-dft;160;162;160;162;161;160;161;161;160;162 12:55:22 INFO - PROCESS | 15855 | |3;audio-fft;76;75;75;108;75;76;76;76;97;76 12:55:22 INFO - PROCESS | 15855 | |4;audio-oscillator;83;84;121;83;82;82;102;83;82;116 12:55:22 INFO - PROCESS | 15855 | |5;imaging-gaussian-blur;118;117;118;117;117;117;118;117;117;118 12:55:22 INFO - PROCESS | 15855 | |6;imaging-darkroom;146;148;146;146;145;147;146;146;146;149 12:55:22 INFO - PROCESS | 15855 | |7;imaging-desaturate;95;95;96;95;95;96;97;95;95;96 12:55:22 INFO - PROCESS | 15855 | |8;json-parse-financial;54;52;51;52;53;53;55;54;52;60 12:55:22 INFO - PROCESS | 15855 | |9;json-stringify-tinderbox;59;61;59;60;61;61;61;61;60;60 12:55:22 INFO - PROCESS | 15855 | |10;stanford-crypto-aes;80;79;87;79;79;79;78;79;80;79 12:55:22 INFO - PROCESS | 15855 | |11;stanford-crypto-ccm;130;129;136;129;135;141;137;145;187;128 12:55:22 INFO - PROCESS | 15855 | |12;stanford-crypto-pbkdf2;170;168;168;168;163;172;171;167;167;166 12:55:22 INFO - PROCESS | 15855 | |13;stanford-crypto-sha256-iterative;67;65;66;67;70;69;65;65;66;64 12:55:22 INFO - PROCESS | 15855 | __end_tp_report 12:55:22 INFO - PROCESS | 15855 | __start_cc_report 12:55:22 INFO - PROCESS | 15855 | _x_x_mozilla_cycle_collect,1651 12:55:22 INFO - PROCESS | 15855 | __end_cc_report 12:55:22 INFO - PROCESS | 15855 | __startTimestamp1475870122077__endTimestamp 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | ------- Summary: start ------- 12:55:22 INFO - PROCESS | 15855 | Number of tests: 14 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.32 (1.2%) stddev-sans-first:0.93 12:55:22 INFO - PROCESS | 15855 | Values: 108.0 112.0 111.0 111.0 110.0 111.0 110.0 113.0 111.0 111.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:126.50 stddev:15.85 (12.5%) stddev-sans-first:15.76 12:55:22 INFO - PROCESS | 15855 | Values: 149.0 121.0 123.0 156.0 122.0 125.0 124.0 123.0 162.0 128.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 12:55:22 INFO - PROCESS | 15855 | Values: 160.0 162.0 160.0 162.0 161.0 160.0 161.0 161.0 160.0 162.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.63 (15.3%) stddev-sans-first:12.20 12:55:22 INFO - PROCESS | 15855 | Values: 76.0 75.0 75.0 108.0 75.0 76.0 76.0 76.0 97.0 76.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.50 stddev:15.36 (18.6%) stddev-sans-first:15.96 12:55:22 INFO - PROCESS | 15855 | Values: 83.0 84.0 121.0 83.0 82.0 82.0 102.0 83.0 82.0 116.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:55:22 INFO - PROCESS | 15855 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 12:55:22 INFO - PROCESS | 15855 | Values: 146.0 148.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 149.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 12:55:22 INFO - PROCESS | 15855 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:2.55 (4.8%) stddev-sans-first:2.70 12:55:22 INFO - PROCESS | 15855 | Values: 54.0 52.0 51.0 52.0 53.0 53.0 55.0 54.0 52.0 60.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 12:55:22 INFO - PROCESS | 15855 | Values: 59.0 61.0 59.0 60.0 61.0 61.0 61.0 61.0 60.0 60.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.56 (3.2%) stddev-sans-first:2.71 12:55:22 INFO - PROCESS | 15855 | Values: 80.0 79.0 87.0 79.0 79.0 79.0 78.0 79.0 80.0 79.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:136.50 stddev:17.54 (12.9%) stddev-sans-first:18.25 12:55:22 INFO - PROCESS | 15855 | Values: 130.0 129.0 136.0 129.0 135.0 141.0 137.0 145.0 187.0 128.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.00 stddev:2.58 (1.5%) stddev-sans-first:2.64 12:55:22 INFO - PROCESS | 15855 | Values: 170.0 168.0 168.0 168.0 163.0 172.0 171.0 167.0 167.0 166.0 12:55:22 INFO - PROCESS | 15855 | 12:55:22 INFO - PROCESS | 15855 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.90 (2.9%) stddev-sans-first:2.00 12:55:22 INFO - PROCESS | 15855 | Values: 67.0 65.0 66.0 67.0 70.0 69.0 65.0 65.0 66.0 64.0 12:55:22 INFO - PROCESS | 15855 | -------- Summary: end -------- 12:55:22 INFO - PROCESS | 15855 | 12:55:23 INFO - TEST-INFO | 15855: exit 0 12:55:23 INFO - TEST-OK | kraken | took 61814ms 12:55:23 INFO - SUITE-END | took 1179s 12:55:23 INFO - Completed test suite (00:19:39) 12:55:23 INFO - javascript benchmark 12:55:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.7604191664664, 3032.3783624357025, 3033.3175035616982, 3062.877484900604, 3077.169164325632, 5056.241563765437, 5103.795848166078, 5217.817376391827, 5306.257124002638, 5335.066363386406, 5216.191490319006, 5235.607329450297, 5261.526462618363, 5309.62832601718, 5358.678479291245, 4759.214729569617, 4771.093492236464, 4777.570018698317, 4778.474367819555, 4910.828121015765, 4918.139325618021, 4940.2342636891335, 4950.331705219804, 4954.529319714639, 4980.651354405193, 4690.718556886598, 4730.432348118214, 4735.147673418784, 4884.5603895649565, 4937.382827146606, 4784.856454306377, 4828.396450443694, 4834.154023045988, 4843.733594652293, 4894.2658601210105, 4751.691140075918, 4773.474917759044, 4780.832670856504, 4798.304245884362, 4811.206150985084, 5115.795368185268, 5272.024675435018, 5282.102042652758, 5283.894322113536, 5355.143177091685, 5486.149646804712, 5575.972120139373, 5579.637323573996, 5584.329880414336, 5588.189712491666, 5602.691851948182, 5604.131359639263, 5614.6631202128, 5620.325560932714, 5624.15637654351, 5198.584113270929, 5242.239875218072, 5253.264542964026, 5257.973710131501, 5258.92111618326, 5674.631148975303, 5720.713964301768, 5723.513501352349, 5724.942750572524, 5725.77096916127, 5538.307711536058, 5562.471565201299, 5565.0, 5644.6330988485615, 5656.85857853557, 5663.207150998864, 5665.065264231355, 5669.914951275734, 5725.656460612377, 5733.455321744427, 5622.522085622686, 5635.915461268084, 5636.661800291996, 5637.069883469264, 5637.23897273871, 5468.398476167618, 5514.751836167382, 5663.377028526858, 5665.3768085510565, 5668.546516278688, 4318.805653745589, 4354.6951713380395, 4356.128774245164, 4362.956370436318, 4408.074304396048, 3843.1160833008566, 3913.25648126855, 3915.236528876899, 3962.4650672159464, 3967.0, 5374.381946076173, 5377.892442151135, 5384.811531596375, 5388.08402571556, 5389.595780316492, 5509.283793106871, 5546.223528705985, 5633.57748168889, 5675.290588676416, 5698.059820129715, 5328.6802791832615, 5330.040592693353, 5332.760025798849, 5350.678959262456, 5352.598555108382, 4759.309900064541, 4921.876953076202, 4941.703497790144, 4943.876403089952, 5000.049990501793, 5720.856978575485, 5830.650160990354, 5876.588638795243, 5912.70436478183, 5985.640861548147, 5730.598858079894, 5737.254156959569, 5739.684317362585, 5744.569157313134, 5746.913796293143, 5913.46778789911, 5924.822255332347, 5930.584859059824, 5932.2584676915385, 5935.961206788881, 5422.403535611001, 5462.481064299044, 5499.670019798825, 5506.862328441821, 5538.446155384429, 5623.465770751772, 5636.351819540805, 5643.209950607001, 5643.407442218508, 5676.631018983753, 5400.594955378441, 5415.972920135374, 5433.157860531624, 5457.0995785696505, 5476.945230547643, 5302.098643230583, 5374.140137577969, 5386.676799392049, 5440.972795135999, 5516.255305533701, 5500.4499550044675, 5510.090835012178, 5527.226188333556, 5545.694986775766, 5566.972165139148, 5554.638948468337, 5556.805511807067, 5559.8888022240135, 5565.415631358649, 5566.944330556643, 5280.339957505312, 5333.386660534088, 5413.756380962787, 5456.372517160418, 5528.7235638218735], "value": 5206.989073214844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1834780394527, 600.6486205569742, 605.9606125601838, 614.4531367083293, 617.2531237202985, 31074.223144421372, 42745.572544274546, 43402.782986085105, 43495.78252108743, 46445.53554464455, 43130.35304470428, 43668.0, 43745.78127109368, 43773.562264377346, 43778.12443751123, 8830.823383532326, 8882.555872206396, 9019.684311049115, 9028.593713282919, 9028.8645670315, 8699.739007829743, 8793.076726943675, 8796.340274479408, 8800.603972821238, 8803.911960880405, 8858.911410885905, 8911.643534258621, 8919.777005574848, 8924.0, 8929.910700892973, 8821.117888211193, 8871.290296776242, 8875.0, 8876.511791851446, 8882.777930551723, 8567.571621418903, 8637.827243455096, 8640.39517233794, 8646.870296945552, 8647.524386158759, 40915.386269205985, 41184.1763164738, 41247.7937610313, 41248.90633202522, 41274.79362603168, 3570.5715314162208, 3691.7231207659534, 3758.0, 3779.433085037239, 3946.8026598669953, 31248.8437557813, 31548.36903261922, 31818.681813181804, 32594.83702581472, 33622.1594460138, 4134.090500089976, 4161.292580261363, 4178.937315940263, 4203.3064544350145, 4218.535961044283, 315402.0, 317609.0, 317829.0, 318447.0, 319386.0, 56741.0, 57187.14219286714, 57190.7140464295, 57241.0, 57273.42726572681, 59307.40692593105, 59420.0, 59420.70289648524, 59444.70277648671, 59468.405315946286, 13314.600561983156, 13623.18260904349, 15915.0, 16429.753553696704, 16457.09485978283, 12649.747005059848, 12720.363981800872, 12731.809022864665, 12734.29961352116, 12737.808932866015, 16215.432459864083, 16258.430954916757, 16275.267612957445, 16370.508884733477, 16640.6671866562, 5407.270018547524, 6278.497720182374, 6287.308396076428, 6521.771737989147, 6650.201975762842, 930.9906900931039, 1011.9038691324313, 1028.2134167361974, 1049.37037777333, 1062.8565143705655, 28891.0, 29098.41803163925, 29333.413331733245, 29377.853110734737, 29424.558631620544, 1071.774927265283, 1077.6928575355985, 1080.6217823761779, 1115.1914861725184, 1156.3813359852438, 15237.314320855367, 16091.839081609034, 16120.27458764335, 16243.350265989227, 16293.837061629232, 475510.0, 475597.0, 478991.0, 480468.0, 480693.0, 55277.06530271502, 55366.0, 55524.722376388665, 55600.16599751007, 55686.0, 1082.7888561730388, 1277.9297138657464, 1295.533607901136, 1327.3031658379427, 1349.1163288046346, 27940.44119117647, 30283.69716302897, 30514.694853052075, 30721.231969200948, 31333.52999705052, 48903.0, 49644.75177624089, 49648.751756240985, 49662.25506617331, 49669.75165124151, 370525.0, 372307.0, 372937.0, 374452.0, 374869.7591168592, 27168.592471113345, 27434.72565274322, 27769.0, 28284.85857570699, 40432.79783601063, 42848.57151428571, 46570.301445479025, 46637.53362466468, 47006.0, 47328.763356183, 38136.618633813305, 39613.40579891246, 40173.59826401698, 40345.798271008454, 41517.37723934083, 39698.80150599228, 40030.1993960125, 40517.797411012754, 40531.79734101311, 41958.0, 39388.21223575455, 39442.211155777295, 40045.0, 40222.0, 40251.396229056, 34197.65802341945, 36002.45996310005, 36058.27883442369, 36509.45235821518, 36849.63150368462, 25044.373890652878, 25142.0, 25530.489390211722, 25549.23352299434, 25567.488650227264], "value": 19340.724423018048, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.89853188904965, 393.9094008378073, 410.65299821650706, 412.2311888328268, 428.4686988134714, 13489.527866524673, 15424.691506169884, 18833.0, 18946.336878209266, 19625.50936226595, 17995.19021644026, 18202.271909123618, 18501.44495665129, 18522.0, 18832.34086806962, 4889.437714662806, 5493.642913210639, 5732.7133643317875, 5735.053716136832, 5735.655860648374, 5595.0, 5671.319441667006, 5699.914501282484, 5702.059160238556, 5702.914456283159, 5453.2092846537225, 5616.9157462638095, 5669.177969194464, 5673.092305231164, 5675.404082571333, 5630.268065151525, 5650.29371328584, 5669.072515344803, 5676.744546495418, 5679.148127780824, 4876.463589005207, 5038.949610503922, 5086.542211200973, 5087.847364579068, 5095.617828662828, 22987.54024919492, 23120.190793322323, 23164.18925337622, 23164.42088947773, 23400.297991060295, 2331.370529956919, 2399.1722855614785, 2467.5558399488086, 2543.910963116282, 2856.228818219069, 14093.78859317111, 14234.0, 14461.71076578473, 14830.851691483054, 14861.554153375417, 1896.2415033986515, 1912.3880358285355, 1954.9609007819906, 1959.1575622482326, 1972.7731310899287, 78667.0, 80215.0, 80302.0, 80797.59601201957, 81052.59473702652, 9940.602375904882, 9974.800503990025, 10325.690229293134, 10490.685279441628, 10604.0, 13955.58133256004, 13957.79063314051, 13957.930210348883, 13958.58124256274, 13963.371648275852, 7286.70853165878, 7516.323530882247, 7528.322450979329, 7659.770206893691, 7811.921880781233, 7060.0, 7127.679254433563, 7272.527285726411, 7294.9270507295305, 7391.1500177480275, 6184.752609895554, 6409.455196308273, 6492.837679058061, 6529.804105876831, 6539.6403197824575, 1891.3663922585813, 1942.1648691062978, 1947.3963071447897, 1971.6648169811167, 2027.3208475160986, 890.4523717913437, 961.2166084640995, 1001.0890090018048, 1042.2339580408393, 1077.5797438998798, 17639.118044097744, 18312.725309120375, 18419.53951151232, 18533.737240434504, 18589.44231673052, 976.472704739447, 979.3487330924997, 982.0, 985.7683444390562, 1012.291396022787, 9960.950195248977, 10509.31689440184, 10787.514561844735, 10808.567657293777, 10818.837717434244, 444047.0, 463500.0, 481136.0, 483436.0, 490192.0, 87608.56195718981, 90831.95641495132, 92276.0, 92637.5368123155, 93965.5301723487, 1026.414943482208, 1034.2450011491653, 1070.0904231403244, 1076.924615276923, 1077.3858900426837, 16070.517884463485, 16459.0, 16721.665566688356, 16857.409990650267, 17095.91452042732, 40491.0, 41659.37510937399, 41934.790326048176, 42243.3663495054, 42273.15453690971, 57176.0, 58857.0, 59168.408315918015, 59216.22351329467, 59225.0, 7862.72480463181, 8104.8784268237205, 8194.426390152632, 8278.420510564443, 8316.501009939422, 11738.823917641072, 12360.629181124581, 12615.36923153857, 12756.362181890683, 12845.807312890502, 11043.282186657842, 11197.776044478902, 11271.380074095676, 11422.143339249424, 11721.882781172078, 10918.181136414642, 10992.340459572451, 11171.329720216812, 11218.102551796, 11711.765764684487, 10322.174226062047, 10863.891361086287, 11196.664100076685, 11497.310161390344, 11638.88361116412, 7882.802929926797, 7981.880271796043, 8080.515169089874, 8330.0, 8368.372372071997, 10221.182305415698, 10604.257701960789, 10815.0, 10818.56725730962, 10977.615783447542], "value": 9125.716658248917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.4686125549786, 1447.7176950494654, 1485.5914623478543, 1573.1898072492668, 1738.4350086221982, 7732.961335193323, 8775.990761062472, 9031.277497800169, 9031.819363612723, 9264.305177111726, 9082.0, 9153.954230228856, 9172.587233574488, 9178.40340377875, 9178.862317065232, 2329.7204335479723, 2348.4363752699314, 2349.1543044503965, 2350.518143780521, 2363.444590521226, 2260.6948062011666, 2307.515421761432, 2315.22439982606, 2331.393837602219, 2336.474293284006, 2310.792028717415, 2331.4870728439714, 2336.2991102669216, 2366.2607983132384, 2369.5616310982523, 2264.750877403484, 2289.3589794857385, 2295.8048565871836, 2300.700908881843, 2318.675385446039, 2294.128231272123, 2299.9310020699404, 2315.6063469210276, 2318.5131122464304, 2326.895289711967, 9074.319426043074, 9125.406848554823, 9125.680601178994, 9131.0, 9435.386699864486, 5342.27879236302, 5448.101063324547, 5474.42518535556, 5474.7810087596445, 5488.0, 3408.522806807049, 3446.3968805458944, 3511.122219445139, 3533.4169861972746, 3550.7336949728874, 1145.507431804324, 1152.112873087726, 1162.4478372772949, 1163.9825402618967, 1167.2062997161927, 12568.560100396442, 12636.49454021838, 12685.556005539855, 12689.682757931125, 12698.301593412358, 4342.500612429548, 4488.708233964782, 4628.861134165981, 4632.2356811126465, 4649.930251046237, 9517.714468565953, 9519.619215231452, 9524.238060955107, 9527.952360238154, 9532.046795320552, 5338.572914166857, 5342.011727830364, 5347.385050719139, 5348.064088784447, 5349.893002139936, 4180.853670121531, 4269.423627810268, 4804.615630749532, 4885.95114048855, 5015.949840501621, 3758.2671379080816, 3848.3457812171996, 3859.517560304962, 3929.685625149981, 3937.0944682723134, 1204.9457774400173, 1206.957756478519, 1208.8670246272902, 1218.214251807579, 1222.6087651951468, 846.3609974469236, 874.1870060843349, 912.1106920752213, 958.6453012385323, 971.931964762474, 6048.092786082035, 6113.541484388688, 6158.414950579688, 6267.2792628847355, 6626.503012274099, 914.1361413464213, 926.3515539122641, 938.7090002099371, 964.1130160252584, 995.7012896131132, 4019.9598004019585, 4122.361034039729, 4214.0, 4246.596573325529, 4248.87253382399, 10975.615853445091, 11457.427128643534, 11460.828087578693, 11484.827727584094, 11491.77016459666, 11395.943020284845, 11397.145214108976, 11399.0, 11408.144389170846, 11445.88554114465, 8051.114377418479, 8468.534230617252, 8529.189726975927, 8601.61292741828, 8604.268637165786, 6002.639841609517, 6233.189685340877, 6365.458935990493, 6396.104545363746, 6440.452561532322, 10631.787364252517, 10682.732931676459, 10685.732856678645, 10698.62554810578, 10803.891961080288, 10148.289619726549, 10539.841902371318, 10545.578176873147, 10797.784044319227, 10832.133429325477, 6928.16861976566, 7120.857582848417, 7122.7507037253445, 7795.57124358143, 7937.365010799007, 7778.105517865518, 7938.642761075881, 8695.434796738191, 8827.558622069, 9047.411918225294, 7781.9610901945125, 7785.0, 7958.0848202455145, 8027.59862006909, 8148.144444833444, 7719.652615632423, 7811.843763124819, 7837.373010159287, 7865.252800983897, 7883.211678832071, 7147.64261786919, 7269.963650181715, 7271.091113610799, 7271.41828653717, 7271.709131634675, 5212.9739351303, 5239.554637855825, 5271.499207575274, 5286.101362768261, 5503.229547863382, 5309.177077552986, 5311.150215965427, 5335.946640533545, 5415.458454154553, 5564.10974244119], "value": 4693.192441638528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.3024234986581, 319.66594908320803, 320.45682568047164, 321.7892280556235, 323.8494100243387, 4993.400791904976, 5164.9483505164935, 5194.688318700876, 5227.242049902762, 5262.368515778103, 4986.675866068703, 5058.772355244014, 5095.3885533736, 5102.158143906251, 5161.354830646169, 4061.2283666103494, 4065.3292206785845, 4070.9796451017705, 4071.124708187739, 4075.9388609170887, 3917.981324855544, 4047.7368971016936, 4080.8571699990507, 4081.265372232997, 4081.9183616327655, 3993.161436098408, 4001.559828418872, 4010.598940105995, 4013.4381186633896, 4030.8186131624147, 3995.2808494470983, 3998.5001874765653, 4006.077083000147, 4009.7594144351433, 4014.7189696721093, 3542.875999340011, 3548.449990251515, 3549.236914063463, 3550.7336949728874, 3574.7855128692363, 4815.0, 4960.87597810054, 4998.800047998076, 5004.3994720633755, 5009.574186194178, 4555.157295900269, 4556.521565235669, 4579.335996280521, 4579.335996280554, 4581.4502259728715, 5343.519083282523, 5348.812791552277, 5353.812616558402, 5356.339534744203, 5361.2226227197225, 3787.5644300905474, 3869.5743468218475, 3892.9416058759143, 3909.980450097731, 3912.4131380292897, 5544.445555444464, 5552.861178470571, 5576.498115169614, 5580.19087232349, 5582.162675598652, 3951.130751234781, 3966.4248683941246, 3969.64273215412, 3984.382420724792, 4027.657649099801, 3776.3957766757185, 3971.4439978403047, 4054.716169868081, 4064.451299074587, 4066.898327541776, 4513.435820522434, 4531.864044078617, 4533.727976321431, 4538.682292239511, 4599.586037256596, 5403.351597808288, 5420.186971954238, 5421.918671219935, 5423.511883930465, 5437.728113594305, 1298.2275546050084, 1317.8286822712987, 1330.6207730796677, 1343.1403901503045, 1358.1579420759192, 894.217559635319, 912.8037471943564, 916.8212198621205, 923.5500264584538, 927.6521304510809, 5033.572146367526, 5048.59611231108, 5054.898902021939, 5062.0, 5066.442691304027, 5435.804123092913, 5436.565074794007, 5437.401885792559, 5445.618806683494, 5453.481919217668, 4916.123596897674, 5037.5214354636255, 5056.469070747592, 5071.923921141186, 5095.337606111182, 2537.3656585853537, 2574.819762616636, 2579.780718638899, 2584.831985920909, 2589.8446093234465, 4918.9508104919205, 4960.627952903475, 4965.478624744422, 4989.80040798364, 4992.326035985096, 4632.97683511587, 4938.493759403416, 4943.047496238965, 4949.208126699711, 4953.25701144824, 4908.226851828706, 4955.776990035457, 4964.354633897642, 4965.82619608312, 4984.750762461862, 4839.830605928775, 4841.419029716316, 4843.539863712942, 4847.770025788177, 4855.684380515255, 4492.528284530077, 4759.42886853566, 4793.161196790478, 4810.350602668595, 4824.421069471686, 4959.628027897994, 4992.552159873596, 4995.0, 5006.724630145377, 5012.824551140692, 3518.595361533354, 3547.8935631931085, 3553.9289214215055, 3561.7862928223353, 3566.8038257896064, 4858.157977583153, 4872.3909511311085, 4887.731174785421, 4912.778924948315, 5204.427512973494, 4682.906341873211, 5307.256984022317, 5365.812196573102, 5371.516563509303, 5412.864678383072, 5348.117560602457, 5351.598630102836, 5374.973125134349, 5395.973020134874, 5402.891942161214, 5247.2744351510855, 5349.545288650508, 5368.946310536845, 5379.5965302603245, 5380.43505431924, 5401.702906340189, 5410.75651595687, 5413.729313534386, 5423.159410291411, 5426.565874729933, 5277.28756617867, 5278.577713782965, 5287.788488460418, 5299.0, 5308.920366194433], "value": 3970.956850855624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.9432292578055, 776.8019155115445, 787.4094429178116, 791.7664289034734, 823.6952327638775, 15166.696666066671, 17034.318627254896, 17064.829351706478, 17066.829331706696, 17080.572985675364, 14515.782263266034, 14598.708025839476, 14599.343029563668, 14614.48849290275, 14626.0, 778.9844203115935, 806.4999700185864, 808.5512540539997, 809.2191035650596, 809.5952023988006, 796.4146352430987, 798.4530596541359, 801.1667865419956, 801.2948605227392, 801.4149670740363, 827.9213474719892, 832.9750107496754, 833.3250067445358, 833.9374546908975, 835.5488036460304, 829.4484168028254, 829.7718127514921, 830.2652152844746, 831.098258389648, 831.1522247307712, 611.245112286326, 611.3916652930362, 611.7338957553478, 611.9296280927706, 612.2041346249857, 13528.25594592297, 13534.661633459144, 13555.59333220005, 13570.728585428335, 13591.524296649668, 12749.574004063772, 13290.534831280858, 13390.732185356335, 13527.256000919946, 13973.23147226902, 11397.544098236061, 11448.026917712004, 11467.254628449124, 11518.078553715683, 11860.0, 3796.2787070456525, 3808.314503389389, 3841.7310788244836, 3946.1910308386714, 4049.088954985134, 48359.75820120912, 54533.0, 56085.71957140188, 65574.0, 77824.61087694582, 11691.0, 11786.0, 11786.528538858349, 12354.320512371905, 12603.0, 21756.020979055666, 22227.22204722859, 22240.666390004164, 22248.66627000564, 22275.443113922283, 8582.0, 8658.307335413152, 8694.95652521746, 8698.086700896441, 8857.512836794038, 4612.377329060601, 4619.284010978304, 4719.7404142772475, 4731.33761273422, 4747.786349614275, 3548.8757893473603, 3680.742348035665, 3694.538182727159, 3701.7408781385043, 3709.221063576625, 664.9700763465559, 669.0866966590569, 676.070403195606, 698.2737952529312, 701.2601705201062, 607.3683369295971, 638.2341190571333, 743.3272888036336, 753.4462170304821, 760.5322726523259, 9156.221721153777, 9346.859797103049, 9782.11960923506, 9984.35101718386, 10026.949865250774, 642.3223499208286, 726.8400951790597, 733.7211859493358, 743.5612988336907, 750.7109762741384, 4429.11417716458, 4681.976590117028, 4712.458067322234, 4745.335653008581, 4809.78355973982, 69380.0, 69786.65106674434, 70044.0, 93234.0, 115330.27004594938, 105585.0, 105957.22556067661, 109503.45248273866, 112649.0, 113843.0, 91663.2992601679, 92602.53698731598, 93994.53002734942, 94218.52890735502, 94786.8862293398, 9098.0, 9129.406588571987, 9134.908650913672, 9252.49111298885, 9281.443113413217, 54304.72847635736, 54763.0, 55225.44774552203, 56072.0, 58238.708806455696, 76992.23007770075, 77751.2224877744, 78424.60787696253, 80991.0, 83251.0, 12372.319522425993, 12573.295400946048, 12837.486500539873, 13038.348082596021, 13067.281299528237, 13770.449182033008, 13855.653608659864, 14052.718945620825, 14530.346134423766, 14693.853061469248, 12057.879421205676, 12167.513299468275, 12732.936335318263, 12735.745285094432, 12975.675608109872, 12713.491460341853, 12884.677883052998, 13018.934905325414, 13057.08600397963, 13181.736365272833, 13871.79192312096, 13883.861161388257, 14105.435782568582, 14218.431262749375, 14837.851621483647, 11047.226694131334, 11254.549818007188, 11304.604338848101, 11415.0, 11817.409129543317, 11455.255408398427, 11464.770704586028, 11501.712457188638, 11684.941575292069, 11777.352245626573], "value": 7492.1208197314745, "unit": "score"}], "name": "dromaeo_css", "value": 7102.155601663376, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 111.0, 111.0, 110.0, 111.0, 110.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 123.0, 156.0, 122.0, 125.0, 124.0, 123.0, 162.0, 128.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 75.0, 76.0, 76.0, 76.0, 97.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 121.0, 83.0, 82.0, 82.0, 102.0, 83.0, 82.0, 116.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 149.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 52.0, 53.0, 53.0, 55.0, 54.0, 52.0, 60.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 87.0, 79.0, 79.0, 79.0, 78.0, 79.0, 80.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 136.0, 129.0, 135.0, 141.0, 137.0, 145.0, 187.0, 128.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 168.0, 168.0, 163.0, 172.0, 171.0, 167.0, 167.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 67.0, 70.0, 69.0, 65.0, 65.0, 66.0, 64.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1505.1000000000001, "alertThreshold": 2.0}]} 12:55:23 INFO - Return code: 0 12:55:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:23 INFO - # TBPL SUCCESS # 12:55:23 INFO - Running post-action listener: _resource_record_post_action 12:55:23 INFO - [mozharness: 2016-10-07 19:55:23.878225Z] Finished run-tests step (success) 12:55:23 INFO - Running post-run listener: _resource_record_post_run 12:55:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393375744; Read time: 168; Write time: 268320 12:55:23 INFO - TinderboxPrint: CPU usage
13.1% 12:55:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 168 12:55:23 INFO - TinderboxPrint: I/O write bytes / time
393,375,744 / 268,320 12:55:23 INFO - TinderboxPrint: CPU idle
8,297.7 (86.9%) 12:55:23 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 12:55:23 INFO - TinderboxPrint: Swap in / out
0 / 0 12:55:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103714816; Read time: 0; Write time: 91284 12:55:23 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289660928; Read time: 168; Write time: 177036 12:55:24 INFO - Running post-run listener: _upload_blobber_files 12:55:24 INFO - Blob upload gear active. 12:55:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:24 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 12:55:24 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'] 12:55:24 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 12:55:24 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:28 INFO - (blobuploader) - INFO - Done attempting. 12:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:55:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:28 INFO - (blobuploader) - INFO - Done attempting. 12:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:29 INFO - (blobuploader) - INFO - Done attempting. 12:55:29 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:29 INFO - Return code: 0 12:55:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2777ba8f9c96415caa4412506916b35a99564432669e5ab3d15436d6b01584d47d5a44b530398d2892ff8bbc1cb2e03d737c29cbc1c619a28a15f48477b523f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fadec9f41a54a98e5f6030f83db5354b64cb96c2fecf8143f06dc2da9c055684068a3d057e522d6a3787a2f38464b138e2195c9247f987493e5ee7a75c2b4c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e496b8129e5e1fe308d3b4365a019f95459f2c72170f70a15487fa3f4db202438622ba5dd2c38df5c7da43a5b5083a7a3161f930befde00cfd4e9f1bebd16c06"} 12:55:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:29 INFO - Contents: 12:55:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2777ba8f9c96415caa4412506916b35a99564432669e5ab3d15436d6b01584d47d5a44b530398d2892ff8bbc1cb2e03d737c29cbc1c619a28a15f48477b523f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fadec9f41a54a98e5f6030f83db5354b64cb96c2fecf8143f06dc2da9c055684068a3d057e522d6a3787a2f38464b138e2195c9247f987493e5ee7a75c2b4c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e496b8129e5e1fe308d3b4365a019f95459f2c72170f70a15487fa3f4db202438622ba5dd2c38df5c7da43a5b5083a7a3161f930befde00cfd4e9f1bebd16c06"} 12:55:29 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:29 INFO - Copying logs to upload dir... 12:55:29 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.343176 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-07 12:55:29.062021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 12:55:29.065771) ========= 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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 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/2777ba8f9c96415caa4412506916b35a99564432669e5ab3d15436d6b01584d47d5a44b530398d2892ff8bbc1cb2e03d737c29cbc1c619a28a15f48477b523f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fadec9f41a54a98e5f6030f83db5354b64cb96c2fecf8143f06dc2da9c055684068a3d057e522d6a3787a2f38464b138e2195c9247f987493e5ee7a75c2b4c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e496b8129e5e1fe308d3b4365a019f95459f2c72170f70a15487fa3f4db202438622ba5dd2c38df5c7da43a5b5083a7a3161f930befde00cfd4e9f1bebd16c06"} build_url:https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/ULKMW8oCQ_2muBYO6TVwXg/artifacts/public/build/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/2777ba8f9c96415caa4412506916b35a99564432669e5ab3d15436d6b01584d47d5a44b530398d2892ff8bbc1cb2e03d737c29cbc1c619a28a15f48477b523f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fadec9f41a54a98e5f6030f83db5354b64cb96c2fecf8143f06dc2da9c055684068a3d057e522d6a3787a2f38464b138e2195c9247f987493e5ee7a75c2b4c6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e496b8129e5e1fe308d3b4365a019f95459f2c72170f70a15487fa3f4db202438622ba5dd2c38df5c7da43a5b5083a7a3161f930befde00cfd4e9f1bebd16c06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 12:55:29.092234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:55:29.092613) ========= 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=32c5991c409366f7fec8a718000001d2-1475868887.553273-693440731 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 12:55:29.178550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 12:55:29.178922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 12:55:29.179285) ========= ========= Total master_lag: 0.18 =========