builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1480710758.54 results: success (0) buildid: 20161202100744 builduid: a9ec26fd24e940498e26f7097a8fa379 revision: 600fb6877b2c277da79aef05d84f242d89068d8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.539935) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.540464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.540780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.555739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.556139) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 12:32:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-12-02 12:32:39 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.701526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.701883) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017216 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.752301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:38.752737) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 600fb6877b2c277da79aef05d84f242d89068d8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 600fb6877b2c277da79aef05d84f242d89068d8f --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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 12:32:39,494 truncating revision to first 12 chars 2016-12-02 12:32:39,494 Setting DEBUG logging. 2016-12-02 12:32:39,494 attempt 1/10 2016-12-02 12:32:39,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/600fb6877b2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 12:32:40,075 unpacking tar archive at: graphics-600fb6877b2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:39.664345) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:39.664680) ========= script_repo_revision: 600fb6877b2c277da79aef05d84f242d89068d8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:39.665091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:39.665415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 12:32:39.676004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-02 12:32:39.676278) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:32:40 INFO - MultiFileLogger online at 20161202 12:32:40 in /builds/slave/test 12:32:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 12:32:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:32:40 INFO - {'append_to_log': False, 12:32:40 INFO - 'base_work_dir': '/builds/slave/test', 12:32:40 INFO - 'blob_upload_branch': 'Graphics', 12:32:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:32:40 INFO - 'branch': 'Graphics', 12:32:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:32:40 INFO - 'config_files': ('talos/linux_config.py',), 12:32:40 INFO - 'default_actions': ('clobber', 12:32:40 INFO - 'read-buildbot-config', 12:32:40 INFO - 'download-and-extract', 12:32:40 INFO - 'populate-webroot', 12:32:40 INFO - 'create-virtualenv', 12:32:40 INFO - 'install', 12:32:40 INFO - 'run-tests'), 12:32:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:32:40 INFO - 'download_minidump_stackwalk': True, 12:32:40 INFO - 'download_symbols': 'ondemand', 12:32:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:32:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:32:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:32:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:32:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:32:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:32:40 INFO - 'installer_path': 'installer.exe', 12:32:40 INFO - 'log_level': 'info', 12:32:40 INFO - 'log_name': 'talos', 12:32:40 INFO - 'log_to_console': True, 12:32:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:32:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:32:40 INFO - 'opt_config_files': (), 12:32:40 INFO - 'pip_index': False, 12:32:40 INFO - 'sps_profile': False, 12:32:40 INFO - 'sps_profile_interval': 0, 12:32:40 INFO - 'suite': 'dromaeojs-e10s', 12:32:40 INFO - 'system_bits': '32', 12:32:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:32:40 INFO - 'title': 'talos-linux64-ix-004', 12:32:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:32:40 INFO - 'use_talos_json': True, 12:32:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:32:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:32:40 INFO - 'work_dir': 'build'} 12:32:40 INFO - [mozharness: 2016-12-02 20:32:40.517486Z] Running clobber step. 12:32:40 INFO - Running pre-action listener: _resource_record_pre_action 12:32:40 INFO - Running main action method: clobber 12:32:40 INFO - rmtree: /builds/slave/test/build 12:32:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:32:40 INFO - Running post-action listener: _resource_record_post_action 12:32:40 INFO - [mozharness: 2016-12-02 20:32:40.980255Z] Finished clobber step (success) 12:32:40 INFO - [mozharness: 2016-12-02 20:32:40.980354Z] Running read-buildbot-config step. 12:32:40 INFO - Running pre-action listener: _resource_record_pre_action 12:32:40 INFO - Running main action method: read_buildbot_config 12:32:40 INFO - Using buildbot properties: 12:32:40 INFO - { 12:32:40 INFO - "project": "", 12:32:40 INFO - "product": "firefox", 12:32:40 INFO - "script_repo_revision": "default", 12:32:40 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 12:32:40 INFO - "repository": "", 12:32:40 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 12:32:40 INFO - "buildid": "20161202100744", 12:32:40 INFO - "pgo_build": "False", 12:32:40 INFO - "basedir": "/builds/slave/test", 12:32:40 INFO - "buildnumber": 29, 12:32:40 INFO - "slavename": "talos-linux64-ix-004", 12:32:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:32:40 INFO - "platform": "ubuntu64_hw", 12:32:40 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 12:32:40 INFO - "branch": "graphics", 12:32:40 INFO - "repo_path": "projects/graphics", 12:32:40 INFO - "revision": "600fb6877b2c277da79aef05d84f242d89068d8f", 12:32:40 INFO - "stage_platform": "linux64", 12:32:40 INFO - "builduid": "a9ec26fd24e940498e26f7097a8fa379", 12:32:40 INFO - "slavebuilddir": "test" 12:32:40 INFO - } 12:32:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:32:40 INFO - Running post-action listener: _resource_record_post_action 12:32:40 INFO - [mozharness: 2016-12-02 20:32:40.982859Z] Finished read-buildbot-config step (success) 12:32:40 INFO - [mozharness: 2016-12-02 20:32:40.982948Z] Running download-and-extract step. 12:32:40 INFO - Running pre-action listener: _resource_record_pre_action 12:32:40 INFO - Running main action method: download_and_extract 12:32:40 INFO - mkdir: /builds/slave/test/build/tests 12:32:40 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:32:40 INFO - trying https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:32:40 INFO - Downloading https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:32:41 INFO - Downloaded 1361 bytes. 12:32:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:32:41 INFO - Using the following test package requirements: 12:32:41 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:32:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:32:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'jsshell-linux-x86_64.zip'], 12:32:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:32:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:32:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:32:41 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:32:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:32:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:32:41 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:32:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:32:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:32:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:32:42 INFO - Http code: 200 12:32:42 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 12:32:42 INFO - x-amz-cf-id: q9kVfp4A3Lwm3tnxa5WQa6jjOMpVAwzkAmIA82hTx5GLMZQMxmTWzg== 12:32:42 INFO - x-amz-version-id: 0br.8KRgOY05HrR3o0IjOHiYTBQcJSwp 12:32:42 INFO - Expected file size: 20217576 12:32:42 INFO - Obtained file size: 20217576 12:32:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:32:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:32:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:32:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:32:46 INFO - Http code: 200 12:32:46 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 12:32:46 INFO - x-amz-cf-id: NaCiYdS9Va_5OagWyn9C2E1wnQfRFJiI6J4kkCvarTnzj_onTuZKJQ== 12:32:46 INFO - x-amz-version-id: 0br.8KRgOY05HrR3o0IjOHiYTBQcJSwp 12:32:47 INFO - Expected file size: 20217576 12:32:47 INFO - Obtained file size: 20217576 12:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:32:52 INFO - Http code: 200 12:32:52 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 12:32:52 INFO - x-amz-cf-id: mSOPCtOyVbTYPAn0GAFKkAfX_D_nWXu7EuiHI93q_YjkTior4kkt5A== 12:32:52 INFO - x-amz-version-id: 6_NuN4.5DHMkDifnFe3_S0OTvRNSM68o 12:32:52 INFO - Expected file size: 14409702 12:32:52 INFO - Obtained file size: 14409702 12:32:52 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:32:52 INFO - trying https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:32:53 INFO - Downloaded 55684546 bytes. 12:32:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:32:53 INFO - mkdir: /builds/slave/test/properties 12:32:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:32:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:32:53 INFO - Contents: 12:32:53 INFO - build_url:https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:32:54 INFO - Running post-action listener: _resource_record_post_action 12:32:54 INFO - Running post-action listener: set_extra_try_arguments 12:32:54 INFO - [mozharness: 2016-12-02 20:32:54.337602Z] Finished download-and-extract step (success) 12:32:54 INFO - [mozharness: 2016-12-02 20:32:54.337830Z] Running populate-webroot step. 12:32:54 INFO - Running pre-action listener: _resource_record_pre_action 12:32:54 INFO - Running main action method: populate_webroot 12:32:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:32:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:32:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:32:54 INFO - '--tppagecycles', 12:32:54 INFO - '7'], 12:32:54 INFO - 'tests': ['tsvgm']}}, 12:32:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:32:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:32:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:32:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:32:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['damp', 'tps']}, 12:32:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'tests': ['damp', 'tps']}, 12:32:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['dromaeo_dom']}, 12:32:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:32:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['basic_compositor_video']}, 12:32:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:32:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'other-e10s': {'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['a11yr', 12:32:54 INFO - 'ts_paint', 12:32:54 INFO - 'tpaint', 12:32:54 INFO - 'sessionrestore', 12:32:54 INFO - 'sessionrestore_no_auto_restore', 12:32:54 INFO - 'tabpaint']}, 12:32:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['tsvgx', 12:32:54 INFO - 'tsvgr_opacity', 12:32:54 INFO - 'tart', 12:32:54 INFO - 'tscrollx', 12:32:54 INFO - 'cart', 12:32:54 INFO - 'tsvg_static']}, 12:32:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:32:54 INFO - 'tsvgr_opacity', 12:32:54 INFO - 'tart', 12:32:54 INFO - 'tscrollx', 12:32:54 INFO - 'cart', 12:32:54 INFO - 'tsvg_static']}, 12:32:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'talos_options': ['--disable-e10s'], 12:32:54 INFO - 'tests': ['tp5o']}, 12:32:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:32:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'talos_options': ['--disable-e10s', 12:32:54 INFO - '--xperf_path', 12:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:54 INFO - 'tests': ['tp5n']}, 12:32:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:32:54 INFO - 'talos_options': ['--xperf_path', 12:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:54 INFO - 'tests': ['tp5n']}}, 12:32:54 INFO - 'talos.zip': {'path': '', 12:32:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:32:54 INFO - Running post-action listener: _resource_record_post_action 12:32:54 INFO - [mozharness: 2016-12-02 20:32:54.358031Z] Finished populate-webroot step (success) 12:32:54 INFO - [mozharness: 2016-12-02 20:32:54.358119Z] Running create-virtualenv step. 12:32:54 INFO - Running pre-action listener: _resource_record_pre_action 12:32:54 INFO - Running main action method: create_virtualenv 12:32:54 INFO - Creating virtualenv /builds/slave/test/build/venv 12:32:54 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:32:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:32:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:32:54 INFO - Using real prefix '/usr' 12:32:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:32:56 INFO - Installing pip.................done. 12:32:56 INFO - Return code: 0 12:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:32:57 INFO - Reading from file tmpfile_stdout 12:32:57 INFO - Output received: 12:32:57 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:32:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:57 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:32:57 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:32:57 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:32:57 INFO - Using env: {'DISPLAY': ':0', 12:32:57 INFO - 'HOME': '/home/cltbld', 12:32:57 INFO - 'LANG': 'en_US.UTF-8', 12:32:57 INFO - 'LANGUAGE': 'en_US:en', 12:32:57 INFO - 'LOGNAME': 'cltbld', 12:32:57 INFO - 'MAIL': '/var/mail/cltbld', 12:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:57 INFO - 'MOZ_NO_REMOTE': '1', 12:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:57 INFO - 'NO_EM_RESTART': '1', 12:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:57 INFO - 'PWD': '/builds/slave/test', 12:32:57 INFO - 'SHELL': '/bin/bash', 12:32:57 INFO - 'SHLVL': '1', 12:32:57 INFO - 'TERM': 'linux', 12:32:57 INFO - 'TMOUT': '86400', 12:32:57 INFO - 'USER': 'cltbld', 12:32:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:57 INFO - '_': '/tools/buildbot/bin/python'} 12:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:57 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:32:57 INFO - Cleaning up... 12:32:57 INFO - Return code: 0 12:32:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:32:57 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:32:57 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:32:57 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:32:57 INFO - Using env: {'DISPLAY': ':0', 12:32:57 INFO - 'HOME': '/home/cltbld', 12:32:57 INFO - 'LANG': 'en_US.UTF-8', 12:32:57 INFO - 'LANGUAGE': 'en_US:en', 12:32:57 INFO - 'LOGNAME': 'cltbld', 12:32:57 INFO - 'MAIL': '/var/mail/cltbld', 12:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:57 INFO - 'MOZ_NO_REMOTE': '1', 12:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:57 INFO - 'NO_EM_RESTART': '1', 12:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:57 INFO - 'PWD': '/builds/slave/test', 12:32:57 INFO - 'SHELL': '/bin/bash', 12:32:57 INFO - 'SHLVL': '1', 12:32:57 INFO - 'TERM': 'linux', 12:32:57 INFO - 'TMOUT': '86400', 12:32:57 INFO - 'USER': 'cltbld', 12:32:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:57 INFO - '_': '/tools/buildbot/bin/python'} 12:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:57 INFO - Downloading/unpacking psutil>=3.1.1 12:32:57 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:32:57 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:32:57 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:32:57 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:32:57 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:32:57 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:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:59 INFO - Installing collected packages: psutil 12:32:59 INFO - Running setup.py install for psutil 12:32:59 INFO - building 'psutil._psutil_linux' extension 12:32:59 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:32:59 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:32:59 INFO - building 'psutil._psutil_posix' extension 12:32:59 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:33:00 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:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:33:00 INFO - Successfully installed psutil 12:33:00 INFO - Cleaning up... 12:33:00 INFO - Return code: 0 12:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:00 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:00 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:33:00 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:33:00 INFO - Using env: {'DISPLAY': ':0', 12:33:00 INFO - 'HOME': '/home/cltbld', 12:33:00 INFO - 'LANG': 'en_US.UTF-8', 12:33:00 INFO - 'LANGUAGE': 'en_US:en', 12:33:00 INFO - 'LOGNAME': 'cltbld', 12:33:00 INFO - 'MAIL': '/var/mail/cltbld', 12:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:00 INFO - 'MOZ_NO_REMOTE': '1', 12:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:00 INFO - 'NO_EM_RESTART': '1', 12:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:00 INFO - 'PWD': '/builds/slave/test', 12:33:00 INFO - 'SHELL': '/bin/bash', 12:33:00 INFO - 'SHLVL': '1', 12:33:00 INFO - 'TERM': 'linux', 12:33:00 INFO - 'TMOUT': '86400', 12:33:00 INFO - 'USER': 'cltbld', 12:33:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:00 INFO - '_': '/tools/buildbot/bin/python'} 12:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:33:00 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:33:00 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:33:00 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:33:00 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:33:00 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:33:00 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:33:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:33:02 INFO - Installing collected packages: mozsystemmonitor 12:33:02 INFO - Running setup.py install for mozsystemmonitor 12:33:02 INFO - Successfully installed mozsystemmonitor 12:33:02 INFO - Cleaning up... 12:33:02 INFO - Return code: 0 12:33:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:33: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:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:02 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:02 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:33:02 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:33:02 INFO - Using env: {'DISPLAY': ':0', 12:33:02 INFO - 'HOME': '/home/cltbld', 12:33:02 INFO - 'LANG': 'en_US.UTF-8', 12:33:02 INFO - 'LANGUAGE': 'en_US:en', 12:33:02 INFO - 'LOGNAME': 'cltbld', 12:33:02 INFO - 'MAIL': '/var/mail/cltbld', 12:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:02 INFO - 'MOZ_NO_REMOTE': '1', 12:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:02 INFO - 'NO_EM_RESTART': '1', 12:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:02 INFO - 'PWD': '/builds/slave/test', 12:33:02 INFO - 'SHELL': '/bin/bash', 12:33:02 INFO - 'SHLVL': '1', 12:33:02 INFO - 'TERM': 'linux', 12:33:02 INFO - 'TMOUT': '86400', 12:33:02 INFO - 'USER': 'cltbld', 12:33:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:02 INFO - '_': '/tools/buildbot/bin/python'} 12:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:02 INFO - Downloading/unpacking jsonschema==2.5.1 12:33:02 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:33:02 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:33:02 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:33:02 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:33:02 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:33:02 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:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:04 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:33:05 INFO - Downloading functools32-3.2.3-2.tar.gz 12:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:33:05 INFO - warning: no files found matching '*.txt' 12:33:05 INFO - no previously-included directories found matching 'build' 12:33:05 INFO - no previously-included directories found matching 'dist' 12:33:05 INFO - no previously-included directories found matching '.git*' 12:33:05 INFO - Installing collected packages: jsonschema, functools32 12:33:05 INFO - Running setup.py install for functools32 12:33:05 INFO - warning: no files found matching '*.txt' 12:33:05 INFO - no previously-included directories found matching 'build' 12:33:05 INFO - no previously-included directories found matching 'dist' 12:33:05 INFO - no previously-included directories found matching '.git*' 12:33:05 INFO - Successfully installed jsonschema functools32 12:33:05 INFO - Cleaning up... 12:33:05 INFO - Return code: 0 12:33:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:33:05 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:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:05 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:33:05 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:33:05 INFO - Using env: {'DISPLAY': ':0', 12:33:05 INFO - 'HOME': '/home/cltbld', 12:33:05 INFO - 'LANG': 'en_US.UTF-8', 12:33:05 INFO - 'LANGUAGE': 'en_US:en', 12:33:05 INFO - 'LOGNAME': 'cltbld', 12:33:05 INFO - 'MAIL': '/var/mail/cltbld', 12:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:05 INFO - 'MOZ_NO_REMOTE': '1', 12:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:05 INFO - 'NO_EM_RESTART': '1', 12:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:05 INFO - 'PWD': '/builds/slave/test', 12:33:05 INFO - 'SHELL': '/bin/bash', 12:33:05 INFO - 'SHLVL': '1', 12:33:05 INFO - 'TERM': 'linux', 12:33:05 INFO - 'TMOUT': '86400', 12:33:05 INFO - 'USER': 'cltbld', 12:33:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:05 INFO - '_': '/tools/buildbot/bin/python'} 12:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:33:05 INFO - Cleaning up... 12:33:05 INFO - Return code: 0 12:33:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:33:05 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:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:05 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:05 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:33:05 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:33:05 INFO - Using env: {'DISPLAY': ':0', 12:33:05 INFO - 'HOME': '/home/cltbld', 12:33:05 INFO - 'LANG': 'en_US.UTF-8', 12:33:05 INFO - 'LANGUAGE': 'en_US:en', 12:33:05 INFO - 'LOGNAME': 'cltbld', 12:33:05 INFO - 'MAIL': '/var/mail/cltbld', 12:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:05 INFO - 'MOZ_NO_REMOTE': '1', 12:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:05 INFO - 'NO_EM_RESTART': '1', 12:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:05 INFO - 'PWD': '/builds/slave/test', 12:33:05 INFO - 'SHELL': '/bin/bash', 12:33:05 INFO - 'SHLVL': '1', 12:33:05 INFO - 'TERM': 'linux', 12:33:05 INFO - 'TMOUT': '86400', 12:33:05 INFO - 'USER': 'cltbld', 12:33:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:05 INFO - '_': '/tools/buildbot/bin/python'} 12:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:33:05 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:33:05 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:33:05 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:33:05 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:33:05 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:33:05 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:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:33: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:33: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:33: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:33: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:33: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:33: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:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:33:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:33:08 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:33:08 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:33:08 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:33:08 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:33:08 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:33:08 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:33:08 INFO - Downloading docopt-0.6.1.tar.gz 12:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:33:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:33:08 INFO - Running setup.py install for blobuploader 12:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:33:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:33:08 INFO - Running setup.py install for requests 12:33:08 INFO - Running setup.py install for docopt 12:33:09 INFO - Successfully installed blobuploader requests docopt 12:33:09 INFO - Cleaning up... 12:33:09 INFO - Return code: 0 12:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33: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:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:09 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:09 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:33:09 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:33:09 INFO - Using env: {'DISPLAY': ':0', 12:33:09 INFO - 'HOME': '/home/cltbld', 12:33:09 INFO - 'LANG': 'en_US.UTF-8', 12:33:09 INFO - 'LANGUAGE': 'en_US:en', 12:33:09 INFO - 'LOGNAME': 'cltbld', 12:33:09 INFO - 'MAIL': '/var/mail/cltbld', 12:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:09 INFO - 'MOZ_NO_REMOTE': '1', 12:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:09 INFO - 'NO_EM_RESTART': '1', 12:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:09 INFO - 'PWD': '/builds/slave/test', 12:33:09 INFO - 'SHELL': '/bin/bash', 12:33:09 INFO - 'SHLVL': '1', 12:33:09 INFO - 'TERM': 'linux', 12:33:09 INFO - 'TMOUT': '86400', 12:33:09 INFO - 'USER': 'cltbld', 12:33:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:09 INFO - '_': '/tools/buildbot/bin/python'} 12:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:09 INFO - Running setup.py (path:/tmp/pip-zsTQfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:09 INFO - Running setup.py (path:/tmp/pip-XRVj5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:09 INFO - Running setup.py (path:/tmp/pip-hbw5Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:09 INFO - Running setup.py (path:/tmp/pip-0Q_anw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:09 INFO - Running setup.py (path:/tmp/pip-ShiJla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:09 INFO - Running setup.py (path:/tmp/pip-Xe_HB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:09 INFO - Running setup.py (path:/tmp/pip-sQcmAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:09 INFO - Running setup.py (path:/tmp/pip-NHpFdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:09 INFO - Running setup.py (path:/tmp/pip-bLrhWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:09 INFO - Running setup.py (path:/tmp/pip-khYp4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:10 INFO - Running setup.py (path:/tmp/pip-33yXpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:10 INFO - Running setup.py (path:/tmp/pip-7VE4d5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:10 INFO - Running setup.py (path:/tmp/pip-3yOy8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:10 INFO - Running setup.py (path:/tmp/pip-8s7VCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:10 INFO - Running setup.py (path:/tmp/pip-I834ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:10 INFO - Running setup.py (path:/tmp/pip-m7So16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:10 INFO - Running setup.py (path:/tmp/pip-L1qqWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:33:10 INFO - Running setup.py install for manifestparser 12:33:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozcrash 12:33:10 INFO - Running setup.py install for mozdebug 12:33:10 INFO - Running setup.py install for mozdevice 12:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:33:10 INFO - Running setup.py install for mozfile 12:33:11 INFO - Running setup.py install for mozhttpd 12:33:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for mozinfo 12:33:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for mozInstall 12:33:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for mozleak 12:33:11 INFO - Running setup.py install for mozlog 12:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for moznetwork 12:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for mozprocess 12:33:11 INFO - Running setup.py install for mozprofile 12:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:33:11 INFO - Running setup.py install for mozrunner 12:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:33:12 INFO - Running setup.py install for mozscreenshot 12:33:12 INFO - Running setup.py install for moztest 12:33:12 INFO - Running setup.py install for mozversion 12:33:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:33:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:33:12 INFO - Cleaning up... 12:33:12 INFO - Return code: 0 12:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33: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:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33: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:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:12 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:12 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:33:12 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:33:12 INFO - Using env: {'DISPLAY': ':0', 12:33:12 INFO - 'HOME': '/home/cltbld', 12:33:12 INFO - 'LANG': 'en_US.UTF-8', 12:33:12 INFO - 'LANGUAGE': 'en_US:en', 12:33:12 INFO - 'LOGNAME': 'cltbld', 12:33:12 INFO - 'MAIL': '/var/mail/cltbld', 12:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:12 INFO - 'MOZ_NO_REMOTE': '1', 12:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:12 INFO - 'NO_EM_RESTART': '1', 12:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:12 INFO - 'PWD': '/builds/slave/test', 12:33:12 INFO - 'SHELL': '/bin/bash', 12:33:12 INFO - 'SHLVL': '1', 12:33:12 INFO - 'TERM': 'linux', 12:33:12 INFO - 'TMOUT': '86400', 12:33:12 INFO - 'USER': 'cltbld', 12:33:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:12 INFO - '_': '/tools/buildbot/bin/python'} 12:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:12 INFO - Running setup.py (path:/tmp/pip-V_ljfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:12 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:12 INFO - Running setup.py (path:/tmp/pip-wr7rl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:12 INFO - Running setup.py (path:/tmp/pip-ZvHFP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:12 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:12 INFO - Running setup.py (path:/tmp/pip-SlM8lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:12 INFO - Running setup.py (path:/tmp/pip-tksvK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:12 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:12 INFO - Running setup.py (path:/tmp/pip-PpYHSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:12 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:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:12 INFO - Running setup.py (path:/tmp/pip-EpvILS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:13 INFO - Running setup.py (path:/tmp/pip-UHHNXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:13 INFO - Running setup.py (path:/tmp/pip-Pa_JFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:13 INFO - Running setup.py (path:/tmp/pip-OVUy3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:13 INFO - Running setup.py (path:/tmp/pip-bdKlfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:13 INFO - Running setup.py (path:/tmp/pip-73ebJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:13 INFO - Running setup.py (path:/tmp/pip-Xu7LRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:13 INFO - Running setup.py (path:/tmp/pip-xckas7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:13 INFO - Running setup.py (path:/tmp/pip-YxpL7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:13 INFO - Running setup.py (path:/tmp/pip-RwnDvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:13 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:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:13 INFO - Running setup.py (path:/tmp/pip-D3JeIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:13 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:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:33:13 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:33:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:33:13 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:33:13 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:33:13 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:33:13 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:33:13 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:33:13 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:33:13 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:33:15 INFO - Downloading blessings-1.6.tar.gz 12:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:33:15 INFO - Installing collected packages: blessings 12:33:15 INFO - Running setup.py install for blessings 12:33:15 INFO - Successfully installed blessings 12:33:15 INFO - Cleaning up... 12:33:16 INFO - Return code: 0 12:33:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:16 INFO - Reading from file tmpfile_stdout 12:33:16 INFO - Current package versions: 12:33:16 INFO - argparse == 1.2.1 12:33:16 INFO - blessings == 1.6 12:33:16 INFO - blobuploader == 1.2.4 12:33:16 INFO - docopt == 0.6.1 12:33:16 INFO - functools32 == 3.2.3-2 12:33:16 INFO - jsonschema == 2.5.1 12:33:16 INFO - manifestparser == 1.1 12:33:16 INFO - mozInstall == 1.12 12:33:16 INFO - mozcrash == 1.0 12:33:16 INFO - mozdebug == 0.1 12:33:16 INFO - mozdevice == 0.49 12:33:16 INFO - mozfile == 1.2 12:33:16 INFO - mozhttpd == 0.7 12:33:16 INFO - mozinfo == 0.9 12:33:16 INFO - mozleak == 0.1 12:33:16 INFO - mozlog == 3.4 12:33:16 INFO - moznetwork == 0.27 12:33:16 INFO - mozprocess == 0.23 12:33:16 INFO - mozprofile == 0.28 12:33:16 INFO - mozrunner == 6.13 12:33:16 INFO - mozscreenshot == 0.1 12:33:16 INFO - mozsystemmonitor == 0.3 12:33:16 INFO - moztest == 0.7 12:33:16 INFO - mozversion == 1.4 12:33:16 INFO - psutil == 3.1.1 12:33:16 INFO - requests == 1.2.3 12:33:16 INFO - wsgiref == 0.1.2 12:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:16 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:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 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:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:16 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:33:16 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:33:16 INFO - Using env: {'DISPLAY': ':0', 12:33:16 INFO - 'HOME': '/home/cltbld', 12:33:16 INFO - 'LANG': 'en_US.UTF-8', 12:33:16 INFO - 'LANGUAGE': 'en_US:en', 12:33:16 INFO - 'LOGNAME': 'cltbld', 12:33:16 INFO - 'MAIL': '/var/mail/cltbld', 12:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:16 INFO - 'MOZ_NO_REMOTE': '1', 12:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:16 INFO - 'NO_EM_RESTART': '1', 12:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:16 INFO - 'PWD': '/builds/slave/test', 12:33:16 INFO - 'SHELL': '/bin/bash', 12:33:16 INFO - 'SHLVL': '1', 12:33:16 INFO - 'TERM': 'linux', 12:33:16 INFO - 'TMOUT': '86400', 12:33:16 INFO - 'USER': 'cltbld', 12:33:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:16 INFO - '_': '/tools/buildbot/bin/python'} 12:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 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:33:16 INFO - Cleaning up... 12:33:16 INFO - Return code: 0 12:33:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:33:16 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:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 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:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:33:16 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 0x7f3db8f49e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e6130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', '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:33:16 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:33:16 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:33:16 INFO - Using env: {'DISPLAY': ':0', 12:33:16 INFO - 'HOME': '/home/cltbld', 12:33:16 INFO - 'LANG': 'en_US.UTF-8', 12:33:16 INFO - 'LANGUAGE': 'en_US:en', 12:33:16 INFO - 'LOGNAME': 'cltbld', 12:33:16 INFO - 'MAIL': '/var/mail/cltbld', 12:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:16 INFO - 'MOZ_NO_REMOTE': '1', 12:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:16 INFO - 'NO_EM_RESTART': '1', 12:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:16 INFO - 'PWD': '/builds/slave/test', 12:33:16 INFO - 'SHELL': '/bin/bash', 12:33:16 INFO - 'SHLVL': '1', 12:33:16 INFO - 'TERM': 'linux', 12:33:16 INFO - 'TMOUT': '86400', 12:33:16 INFO - 'USER': 'cltbld', 12:33:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:16 INFO - '_': '/tools/buildbot/bin/python'} 12:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:33:16 INFO - Cleaning up... 12:33:16 INFO - Return code: 0 12:33:16 INFO - Running post-action listener: _resource_record_post_action 12:33:16 INFO - Running post-action listener: _start_resource_monitoring 12:33:16 INFO - Starting resource monitoring. 12:33:16 INFO - [mozharness: 2016-12-02 20:33:16.755993Z] Finished create-virtualenv step (success) 12:33:16 INFO - [mozharness: 2016-12-02 20:33:16.756517Z] Running install step. 12:33:16 INFO - Running pre-action listener: _resource_record_pre_action 12:33:16 INFO - Running main action method: install 12:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:16 INFO - Reading from file tmpfile_stdout 12:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 12:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:33:17 INFO - Reading from file tmpfile_stdout 12:33:17 INFO - Output received: 12:33:17 INFO - Usage: mozinstall [options] installer 12:33:17 INFO - Options: 12:33:17 INFO - -h, --help show this help message and exit 12:33:17 INFO - -d DEST, --destination=DEST 12:33:17 INFO - Directory to install application into. [default: 12:33:17 INFO - "/builds/slave/test"] 12:33:17 INFO - --app=APP Application being installed. [default: firefox] 12:33:17 INFO - mkdir: /builds/slave/test/build/application 12:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:33:33 INFO - Reading from file tmpfile_stdout 12:33:33 INFO - Output received: 12:33:33 INFO - /builds/slave/test/build/application/firefox/firefox 12:33:33 INFO - Running post-action listener: _resource_record_post_action 12:33:33 INFO - [mozharness: 2016-12-02 20:33:33.108010Z] Finished install step (success) 12:33:33 INFO - [mozharness: 2016-12-02 20:33:33.108252Z] Running run-tests step. 12:33:33 INFO - Running pre-action listener: _resource_record_pre_action 12:33:33 INFO - Running main action method: run_tests 12:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:33:33 INFO - Python 2.7.3 12:33:33 INFO - Return code: 0 12:33:33 INFO - grabbing minidump binary from tooltool 12:33:33 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:33:33 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 0x2774fc0>, '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 0x2775ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:33:33 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:33:33 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:33:33 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:33:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:33:33 INFO - Return code: 0 12:33:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:33:33 INFO - Using env: {'DISPLAY': ':0', 12:33:33 INFO - 'HOME': '/home/cltbld', 12:33:33 INFO - 'LANG': 'en_US.UTF-8', 12:33:33 INFO - 'LANGUAGE': 'en_US:en', 12:33:33 INFO - 'LOGNAME': 'cltbld', 12:33:33 INFO - 'MAIL': '/var/mail/cltbld', 12:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:33 INFO - 'MOZ_NO_REMOTE': '1', 12:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:33 INFO - 'NO_EM_RESTART': '1', 12:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:33 INFO - 'PWD': '/builds/slave/test', 12:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:33:33 INFO - 'SHELL': '/bin/bash', 12:33:33 INFO - 'SHLVL': '1', 12:33:33 INFO - 'TERM': 'linux', 12:33:33 INFO - 'TMOUT': '86400', 12:33:33 INFO - 'USER': 'cltbld', 12:33:33 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004', 12:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:33 INFO - '_': '/tools/buildbot/bin/python'} 12:33:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:33:33 INFO - mozversion application_buildid: 20161202100744 12:33:33 INFO - mozversion application_changeset: 600fb6877b2c277da79aef05d84f242d89068d8f 12:33:33 INFO - mozversion application_display_name: Nightly 12:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:33:33 INFO - mozversion application_name: Firefox 12:33:33 INFO - mozversion application_remotingname: firefox 12:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 12:33:33 INFO - mozversion application_vendor: Mozilla 12:33:33 INFO - mozversion application_version: 53.0a1 12:33:33 INFO - mozversion platform_buildid: 20161202100744 12:33:33 INFO - mozversion platform_changeset: 600fb6877b2c277da79aef05d84f242d89068d8f 12:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 12:33:33 INFO - mozversion platform_version: 53.0a1 12:33:33 INFO - using testdate: 1480710813 12:33:33 INFO - actual date: 1480710813 12:33:33 INFO - starting webserver on 'localhost:58491' 12:33:33 INFO - SUITE-START | Running 2 tests 12:33:33 INFO - TEST-START | dromaeo_css 12:33:33 INFO - operating with platform_type : linux_ 12:33:33 INFO - Initialising browser for dromaeo_css test... 12:33:33 INFO - TEST-INFO | started process 19325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_8bJWI/profile http://localhost:58491/getInfo.html) 12:33:38 INFO - PROCESS | 19325 | __metrics Screen width/height:1600/1200 12:33:38 INFO - PROCESS | 19325 | colorDepth:24 12:33:38 INFO - PROCESS | 19325 | Browser inner width/height: 1024/697 12:33:38 INFO - PROCESS | 19325 | __metrics 12:33:38 ERROR - PROCESS | 19325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 12:33:39 INFO - TEST-INFO | 19325: exit 0 12:33:39 INFO - Browser initialized. 12:33:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:33:39 INFO - TEST-INFO | started process 19448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_8bJWI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:51 INFO - PROCESS | 19448 | RSS: Main: 187793408 12:33:51 INFO - PROCESS | 19448 | 12:34:41 INFO - PROCESS | 19448 | 1480710881450 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:36:55 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58491/tests/dromaeo/cssquery-ext.html) 12:36:56 INFO - PROCESS | 19448 | RSS: Main: 197140480 12:36:56 INFO - PROCESS | 19448 | 12:39:59 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-ext.html (next: http://localhost:58491/tests/dromaeo/cssquery-jquery.html) 12:39:59 INFO - PROCESS | 19448 | RSS: Main: 197279744 12:39:59 INFO - PROCESS | 19448 | 12:43:02 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58491/tests/dromaeo/cssquery-mootools.html) 12:43:02 INFO - PROCESS | 19448 | RSS: Main: 199462912 12:43:02 INFO - PROCESS | 19448 | 12:46:04 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58491/tests/dromaeo/cssquery-prototype.html) 12:46:05 INFO - PROCESS | 19448 | RSS: Main: 196268032 12:46:05 INFO - PROCESS | 19448 | 12:49:08 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58491/tests/dromaeo/cssquery-yui.html) 12:49:09 INFO - PROCESS | 19448 | RSS: Main: 199090176 12:49:09 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | Cycle 1(1): loaded http://localhost:58491/tests/dromaeo/cssquery-yui.html (next: http://localhost:58491/tests/dromaeo/cssquery-dojo.html) 12:52:12 INFO - PROCESS | 19448 | RSS: Main: 199053312 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | __start_tp_report 12:52:12 INFO - PROCESS | 19448 | _x_x_mozilla_page_load 12:52:12 INFO - PROCESS | 19448 | _x_x_mozilla_page_load_details 12:52:12 INFO - PROCESS | 19448 | |i|pagename|runs| 12:52:12 INFO - PROCESS | 19448 | |0;dojo.html;2576.433184699367;2588.715241323454;2641.4981153580807;2645.801564882634;2669.359353755099;4647.814087436498;4791.880202994927;4818.036392721457;4829.420469543656;4838.709677419357;4704.600108990731;4749.311349854269;4765.237561990082;4770.212914869043;4841.2496063110275;4259.041715613986;4268.87193384199;4325.956740432603;4382.12357528494;4418.9337159942625;4297.269464191095;4389.122175564884;4401.713888597247;4425.645948324142;4438.334249862531;4293;4384.18892504886;4409.603135717769;4414.757188354639;4442.022754993896;4314.546972567867;4362.36745671879;4377.146456440963;4378.365137055141;4395.824167033346;4318.157959197958;4350.912981740347;4354.455693038371;4355.194289056503;4361.084172323815;4730.479647238801;4735.052989402134;4741.620670346364;4761.571458568711;4792.257200133985;5091.541761241469;5092.388913330387;5101.8724531887;5117.257997590328;5153.2785410042625;5128.948710512885;5147.588192944556;5157.097507936133;5168.9224661630105;5182.896342073137;4678.532146785295;4693.95306046942;4726.881827954328;4744.810207591727;4794.784234709412;5216.739163041832;5224.843254702365;5235.842924712265;5241.580673546107;5283.260343551906;4978.8257410990445;5008.12357837377;5022.196448568212;5026.421961474477;5075.3148324975655;4936;4998.2002879539095;5098.643094983316;5100.744962751847;5149.716765577854;5005.049040682259;5018.799248030111;5027.421846487628;5090.440051594322;5129.333186685707;5035.79856805731;5064.316317297192;5097.923531147036;5100.336956195671;5107.080725469377;4229.2598795210715;4335.6965012449455;4355.651547876162;4361.956380436155;4408.294672852392;3682.815859207029;3726.8136593170234;3751.0622344413896;3751.268502642013;3835.252125835491;4400.031992961543;4426.690131690815;4432.82268709248;4441.11177764442;4469.173202957463;5096.159133742891;5111.693298402108;5111.897762044739;5115.130427827278;5180.456052114474;4307.375430562551;4325.070109926381;4328.04782947751;4350.912981740411;4354.586314300136;4470.575295346936;4536.818527258939;4538.818447262072;4554.4990051094355;4561.521040290721;4735.100330937111;4768.070226305837;4790.952090479051;4795.328653988514;4824.107540105092;5104.2088476286235;5104.69371837691;5129.358830146231;5129.538341549279;5165.173572228426;4683.555062269079;4730.053989202104;4760;4763.214069678603;4799.760011999456;4987.850364489072;5023.447420783637;5042.520960508746;5049.368828896388;5097.286379906742;5084.5932325414615;5126.6923984561045;5131.640785145004;5138.177891537336;5170.276161337491;4831.903361932812;4952;4999.950000500094;5028.044671512401;5033.798648054037;4869.342638743724;4908.7545622719435;4922.384701912261;4925.285833554043;4927.926081108714;4860.684055536379;4884.609231261562;4893.486183950634;4960.70235785854;4982.800687972441;5059.797608095782;5072.28987941681;5079.11115554769;5090.4655011223285;5111.565516930954;4864.246041863516;4883.194272944925;4923.679960802537;4923.950760492349;4926.064047830901 12:52:12 INFO - PROCESS | 19448 | |1;ext.html;525.2226704477373;537.231758585223;537.9193121031846;540.7917951588637;546.4808431989611;37614.81192594037;39462.210755784865;39516.80241598795;39539.20921581574;42776.3583546247;38672.41991370132;38920.80539597305;39134;39144.41283380752;39310.01724956877;7546.4717469777;7621.695132194705;9615.807683846353;9913.256505762096;9913.405195688245;9778.511074446285;9857.260705447085;9867.407955522656;9872.703818885446;9875.654352097677;9931.801363972716;9970.800583988315;9972.351797133164;9978.052085051944;9978.101970822625;9753.82954045519;9821.558029888636;9870.062344077302;9886.406815591088;9891.752706182404;9647.807043859153;9716.076972687653;9717.514124293757;9718.173955213744;9718.805623887554;36715;37004.25991480182;37081.81459092687;37113.25773484542;37239.441408378894;2742.3829638331417;2776.7223277672274;2861.2989817494845;2898.826070435781;3297.9835100824585;27396.58905116425;27652.446951060865;27726.808362195578;27745;28540.571891421645;3447.3277710846396;3497.0452401052585;3515.490253913194;3529.770564913272;3530.3645343838098;235991;237217;237632.81183594145;238694;238830;50863.23705144426;51235.487645123816;51251;51360.229596556084;51364.48635513597;50788.49211507911;54426.45573544293;54459.72770136203;54527.182092268646;54589.45410545844;11556.76886462266;13783.655408614664;13987.37056832445;14022.22877741734;14038.508652197124;8645.870311945326;10434.582616695247;10586.629467968583;10636.946815265874;10830.40432776205;16799.748003779954;16833.32666693343;16841.242144103544;16864.578385540215;17231.138443077794;6531.216254049449;6605.372489613479;6613.3056029117215;6627.768028118992;6752.5948443093575;769.7190525458279;844.2992316377392;863.0592654007162;938.9108034736689;955.9091886270793;25765.74234257671;26933.595996060074;27184.340675710897;27241.455170896472;27366.589501157498;918.2332752151895;922.7462447826902;972;996.8903420623726;1000.2698030437675;14246.928765356313;14399;14411.567652970427;14570.125792452487;14682.853171468149;340764;342709;342781;344113.1475537689;347625;46121.308180377324;46701;46967.76516117398;47095.76452117786;47096;1121.1927412263158;1152.274067337572;1160.0893298760432;1165.930044197351;1168.6902970712767;25655.615165772902;26202.73797262003;26760.59859102154;26836.194914151827;27217.72782272231;40040.799796000836;40359.79820100881;40396.596034039285;40429.79785101055;40527.79736101301;308911;309028;310078;310284;310634;23313.184038558567;23751.52496950086;23881.641775373035;23916.28251152468;25020.124295650294;39303;39842.80471585857;40104.39843402409;40132.266964134586;40597.79701101476;33804.154896127795;33863.83068084644;33940.15149621279;34230.82884585561;34435.65564344324;33487.66512334943;33748.325033499685;34007.4898876522;34086.65913340835;34776.82611587027;33752;33967.4904876432;33989;34157.31685366329;34878;28550.57174142348;31296.21759456032;31366.52950205703;31412.842935785175;31521.52717709282;24462.75537244605;24537.509249815263;24695.50608987846;24938;24983.625245620966 12:52:12 INFO - PROCESS | 19448 | |2;jquery.html;348.44597090625916;351.8821194899708;352.63326140813547;364.4151137424435;368.84508506427295;15489.767653485193;16257.674846503063;16398.590035249126;16424.999999999985;16601.252943617535;15645.843541564582;16436.671266574693;16597.66804663906;16603.584910377245;16651.583710407245;4658.557437043484;5026.874328141789;5062.670926389791;5076.746162691869;5084.389873215219;3633.073566240618;3836.462895194675;4988.675736077162;5087.694738315695;5639.464250896179;5946.821595352147;6013.639181649115;6116.357782432825;6145.784897528587;6146.078088286748;5882.617629854046;6023.397660233985;6039.184710064151;6065.302490213638;6116.938830611703;5258.789648414097;5273.525382715574;5274.630775845692;5281.762320695578;5283.313169288006;20143.294984675613;20717.171313147457;20871.58256834855;21236.407269454852;21383.465413364636;1754.9824501755074;1831.532959095422;1845.1881172284152;1926.566522532433;2400.5198960207854;12279.570215042431;13046.673833154153;13617.591472255848;13677.452901883913;13748.518801841887;1660.7093758592318;1688.8902221355572;1730.3338214787273;1759.289135992457;1773.6807374672553;65755.3424465754;66499.66750166267;67456.6627166861;68388.3161168392;70583.29416705818;8946.68686595966;9027.187553120251;9308.581113849894;9345.158935695685;9602.90397096034;12753.298568578632;12780.360981950866;12794.744105118032;12820.166689165175;13081.542146024844;6719.883236780496;7044.647767611599;7202.279772022861;7216.5670059796585;7236.9276307237305;6683.866322673519;6716.832079197961;6801;6939.965300173467;6981.511294209458;5802.33273173582;5992.970035149883;6018.909716354171;6046.3651316612;6109.236345456818;1611.6534944986884;1656.2960741684976;1705.9232334544974;1751.211954620426;1797.1553369916119;802.9357651387875;844.7550210438903;903.9728808135767;938.4134915677702;942.8868535775614;17028.659426811642;17396.3041478342;17640.823591763918;18085.095745212686;18491.352802651843;754.1741792736944;824.4393812207636;826.273089243472;839.6599377252222;858.7080392666523;9223.584938677775;10324.845127323097;10330.79868736206;10360.222983276284;10468.424236666904;348547;353195;354825;356348;358532;77465;79523;80479.19520804835;82482.58758706288;84039.5798021006;864.3387808326635;879.7580665316962;908.1281969309405;913.7030465098869;918.7289749523907;14812.074430323988;15184.392624294904;15413.306401212196;15628.765568516708;15845.445409410615;36893.63106368902;37553.6244637561;37928.810355948044;38182.809085954395;38339.23321533498;47057;48620.27069594029;51243.48756512387;51517;53922;6927.89608155868;7073.50485466033;7268.563886166847;7316.780496585111;7336.860670193876;10447.738806529898;10901.291416057931;11208.943955280172;11214.271072380268;11350.659480215607;9721.4653194075;9929.950350248202;9971.45157016371;10008.84986725185;10292.330998485373;10046.146077583488;10158;10159.898401015895;10284.485775711035;10436.321639093434;10135.695929122137;10177;10278.845817312897;10284.2801003932;10704.89295107039;7329.780106596811;7394.963025184839;7474.925250747423;7492.213317601573;7555;7488.9625551871895;9292.907070929205;9311.534423278945;9586.568604412958;9665.951670241604 12:52:12 INFO - PROCESS | 19448 | |3;mootools.html;1317.683755898584;1362.7887677410001;1408.2184387664847;1611.0333799720177;1638.3610391947143;6162.568620196588;6336.239651241846;6524.445422139118;6874.965625171873;6885.827854303639;6719.697613607387;6941.132358455193;6952.96523517383;6954.44364450844;6971.477139214554;2017.6166528359638;2040.1329434990143;2043.8467114966363;2047.9795202048012;2058.5985732782115;2012.5773587546632;2017.6469117904307;2024.2409096588779;2063.3397312859893;2066.6590012647894;1997.6703843865744;2001.539645881441;2017.576308975117;2022.8381729461607;2026.2097781865084;1948.2109745553073;1962.6859702447682;1966.5575245569776;1973.851961102923;1979.4853338132045;1942.7377304063912;1974.5162435203467;1981.564055907698;1984.1468168687459;1986.7615886093618;6755.594664320157;6874.553154045021;6888.621125838077;6935.098437203182;6953.826154346131;4092.7544347339253;4206;4215.725977811432;4219.261629214875;4236.301010333292;2517.358073691197;2662.720414356484;2729.713380095101;2758.724127587245;2807.087696498646;882.5057967538199;911.1571796088658;927.4064598656865;934.1545900959643;947.0340252942029;9055.592498337524;9056.818863622691;9089.136532029446;9092.909070909338;9129.360944733939;3650.762700424517;3781.5840257571645;3852;3863.343231650626;3883.1457079442475;8008.479448835807;8009.4393392463135;8014;8018.077921039038;8028.438009339407;4195;4210.431591735138;4212.283911734951;4215.494140703136;4216.704830661824;3302.5046243063734;3401.5067815166663;3740.831662575191;3836.865709700147;3838.4626152338697;3277.885274015398;3280.327532855759;3411.1301618087227;3418.3163367326633;3426.3318652862454;1080.5407701726735;1091.4051841746268;1108.3737688206138;1111.0223003756641;1125.071815752008;653.7123665587221;787.3504358903928;792.944493885434;814.8085199978001;827.1356432527903;4632.953670463252;4646.605038571692;4653.534646535387;4897.510248975145;4903.656744027955;774.6823802241166;799.6121880887765;801.0587559617543;829.531314807132;830.4560512864084;3106.4718997770433;3118.547810567455;3174.3016536361965;3220.0661808075397;3231.5475833383343;8060.677572897136;8492.575371231414;8496.192861678132;8502.149785021573;8518.233358997595;8419.242268195769;8433.662653493915;8441.113683063313;8459.577021149042;8459.788505287293;6505.674716264262;6639.236487803868;6642.701078451385;6655.43428808547;6657.434118099919;4484.798184081659;4614.976925115353;4633.166030114612;4903.77932993009;4903.901921961612;7497.850042999218;7637.732679356196;7668.271514206142;7679.654415551202;7697.384209263358;7502.887456688045;7582.886256706264;7607.695692172472;7656.578888161204;7668.348190403655;5221.791128354823;5378.650387724785;5892.970535147297;6102.572819902742;6112.32764395925;6061.39386061408;6214.378562143749;6221.595596286227;6383.744650213939;6385.23377194721;5706.543476521952;5885.970570147122;5936.554758393224;5971.761129554943;6038.69806509664;5779.306483222041;5814.5639077068545;5825.446582574648;5887.41125887425;5937.198478205387;5411.2965314508865;5473.972630136824;5517.613767036269;5527.8894422112135;5535.25274087993;3888.8250028748207;3957.703172262034;3958.267720471722;4020.0954785173103;4033.5764744701382;4000.6399424051974;4033.3949907514107;4174.311238645711;4214.515330737005;4258.041940563348 12:52:12 INFO - PROCESS | 19448 | |4;prototype.html;267.5825711889453;268.40682092575406;273.7563568424103;273.7727686020603;275.7862656441258;4948.876278093049;4987.800487980481;5007.248912663098;5016.372953380827;5032.295478632995;4920.212765957447;4924.926126108111;4926.9753651231695;4931.580815630676;4944.431390390107;3557.8576856925692;3643.143861192618;3668.7248456365746;3769.396896496561;3788.2423515296914;3760.736748427611;3771.4154306082464;3774.77351358918;3777.7355585108917;3789.2989796887528;3728.1798004439115;3746.9625303746884;3747.4566187902874;3752.6059763724825;3776.8678096266635;3665.9450108248398;3693.8707145249787;3764.1342491227033;3771.1703425246537;3777.338965680995;3212.3254116635535;3240.708336249725;3249.2689144942437;3259.3807176636365;3271.2312606537444;4808.519148085164;4813.78337974792;4822.1561226785525;4833.734144622044;4833.879153021167;4300.956990430087;4308.913821723548;4309.698321117523;4311.676624253194;4318.179545886272;4905.681130726492;5131.640785145041;5141.280220769096;5146.176611742103;5182.663126896739;3580.3913334733156;3584.731145164097;3584.731145164123;3590.317839610466;3594.748367614268;5380.399758206755;5385.542228910547;5392.649477783932;5394.7842086316505;5419.943111093377;3397.371486275047;3517.806520641338;3681.4293784463453;3683.324087540163;3698.167912219783;3622.347977364047;3623.80069096197;3633.364161271767;3637.127089498554;3642.25333806569;4205.957940420618;4212.157568486254;4214.388913607571;4219.9578004220175;4225.450691410097;5120.436751957282;5157.922631160461;5158.252053452304;5161.741912904415;5175.560077393464;1184.6505280942142;1216.7323188898429;1230.5200971621075;1231.2920070959235;1234.5370486067725;793.6507936507844;816.1715858403725;829.2163905109613;829.7759604906641;832.3715594726065;4341;4366.755474689761;4519.141363140992;4527.230370836965;4630.189716799547;5366.302380690563;5373.898350838069;5386.946130538723;5388.057090009311;5388.38033626138;4667.369905062773;4668.533146685304;4670.276107203389;4675.298705194248;4677.368555245066;2713.66079240095;2727.677076617839;2748.69764325924;2756.393593409487;2796.5944937983877;4831;4836.992648051019;4848.393950756155;4849.975750121297;4853.432726945692;5081.415637201695;5330.227117068003;5346.599005074635;5357.705326207096;5360.249565060894;4817.470078291385;4824.445188803333;4825.541573550507;4837.032593481318;4847.684900481458;5190.598538394688;5194.844154675366;5202.921956170585;5235.581153507634;5239.764210610456;4919.868430260988;5006.924896126634;5095.184770436712;5113.897722045613;5141.871453213699;4778.4982576830325;4795.848996240947;4808.903821923612;4825.697061793226;4828.734419606955;3596.3706351387877;3610.7833529988284;3617.330793803155;3627.4014787560814;3629.274145171029;5005.649604527648;5209.635325527177;5210.400803907448;5214.791408343775;5222.086134926297;4996.825111121093;5013;5026.44709082008;5027.446980832033;5041.344625198701;5016.899662006666;5057.443681195139;5083.534485774322;5104.872378190426;5124.487551244994;4737.455192652889;4980.513640451626;4985.077760614298;4997.750112494434;5009.799608015638;5012.824551140692;5027.7737501813235;5098.898022039612;5140;5292.465185096433;5134.176203088361;5138.152204886152;5139.974300128475;5160.432352441304;5163.483651634807 12:52:12 INFO - PROCESS | 19448 | |5;yui.html;629.1663545801814;629.9905501417479;666.7666316789122;714.8677494663488;730.2697302697301;11597.3041617503;12433.440495177727;12476.750464990695;12514.624561263165;12534.749305013895;12251.20367176133;12255.816162757566;12322.507099716024;12390.876091239084;12427.067969902248;743.7805847275054;755.7128291249318;756.6897571995482;757.0158793568366;758.9127250366223;606.3814908793029;625.1466747889144;730.1493759769888;756.2097607999654;760.8174038230812;793.6428607126787;801.5551368990208;801.587182600961;801.9599020049003;804.5454318310136;797.6251161953901;797.7447216890597;798.0543056478064;799.3405440511601;799.3684988858853;587.0577722755003;587.8089620873234;588.2470437839572;588.3792598808255;588.8115802943059;12724.554640587536;13056.412461439162;13081.215127092404;13128.737425251442;13140.540081097115;13318.269754700263;13493;13690.178589284675;13801.861981380258;13827.101238419471;9898.158656514204;10011.549480273332;10030.799384012353;10294.845577316346;10359.223058270585;3204.4872820348633;3223.403670320998;3255;3281.5569898063695;3284.096873359845;61102.388976110116;61272.693636531534;61609;62002.689986549776;62815.685921570555;8880.8667869982;9102.453852768855;9312.48781317034;9360.297977651704;9447.574859131355;18445.7233141503;18550.814491855177;18572.721409178874;18648.347307844433;18908.149133289036;6200.81397558074;6231.3145553989025;6273.7176827042895;6359.2368915729485;6403.295637479873;3345.4145524533596;3466.2374277658873;3468.2890007548895;3514.5606799150105;3582.4805403216387;2659.6675415573054;2771.362586605052;2777.472280266743;2781.680106787705;2784.8189867658944;413.128299288501;413.5616246778425;423.69070578477266;430.7759964818277;431.37450696490214;611.6421893192532;618.5515501261549;625.9342769009279;631.709413669717;639.2105749399487;7990.600469976478;8165.183481651906;8312.459690120122;8538.44500107491;8549.914500854911;516.377764793423;553.7098560354365;572.8510587247346;615.5875563372551;619.6189343553772;3655.8720444784303;3779.7132734695665;3781.716371272166;3879.165979314461;3899.6880249579967;52260.477395225564;52924.206136907975;53007;54840.72579637076;55123;52931;53397;54623.726881365335;54715.17927231095;55118.72440637771;49811;50028;50805.23792143121;50818.74590627023;52519.73740131275;8403.957980210304;8417;8433.789155271168;8511.148885111439;8596.65613375483;35746.64253357433;36103.63896361003;36230.818845905604;36701.26597468089;38364.61635383611;43502.34746478868;48932;49779;50048;50436.747816260686;10270.229732769923;10321.48392580383;10407.427591482237;10610.840837387292;11211.159163062639;12787.232766034067;12930.482780688668;12978;13030.739385212053;13419.597412077654;11620.941895290807;12159.088068394729;12525.686857828627;12590.370481475706;13065.346732663518;11779;11862.347570883685;12103.152779305365;12194.634160975185;12478.313692746622;11744.823827642764;12652.590480850156;12681.30252836066;12734.872651273368;12773.808392873929;9280.396774209656;9315.39449935752;9531.904680953101;9547.904520954979;9653.517324133625;9299;10085.596576137166;10110.595576176871;10203.795924081625;10394.480275986321 12:52:12 INFO - PROCESS | 19448 | __end_tp_report 12:52:12 INFO - PROCESS | 19448 | __start_cc_report 12:52:12 INFO - PROCESS | 19448 | _x_x_mozilla_cycle_collect,335 12:52:12 INFO - PROCESS | 19448 | __end_cc_report 12:52:12 INFO - PROCESS | 19448 | __startTimestamp1480711932378__endTimestamp 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | ------- Summary: start ------- 12:52:12 INFO - PROCESS | 19448 | Number of tests: 6 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#0] dojo.html Cycles:165 Average:4706.75 Median:4829.42 stddev:506.17 (10.5%) stddev-sans-first:479.34 12:52:12 INFO - PROCESS | 19448 | Values: 2576.4 2588.7 2641.5 2645.8 2669.4 4647.8 4791.9 4818.0 4829.4 4838.7 4704.6 4749.3 4765.2 4770.2 4841.2 4259.0 4268.9 4326.0 4382.1 4418.9 4297.3 4389.1 4401.7 4425.6 4438.3 4293.0 4384.2 4409.6 4414.8 4442.0 4314.5 4362.4 4377.1 4378.4 4395.8 4318.2 4350.9 4354.5 4355.2 4361.1 4730.5 4735.1 4741.6 4761.6 4792.3 5091.5 5092.4 5101.9 5117.3 5153.3 5128.9 5147.6 5157.1 5168.9 5182.9 4678.5 4694.0 4726.9 4744.8 4794.8 5216.7 5224.8 5235.8 5241.6 5283.3 4978.8 5008.1 5022.2 5026.4 5075.3 4936.0 4998.2 5098.6 5100.7 5149.7 5005.0 5018.8 5027.4 5090.4 5129.3 5035.8 5064.3 5097.9 5100.3 5107.1 4229.3 4335.7 4355.7 4362.0 4408.3 3682.8 3726.8 3751.1 3751.3 3835.3 4400.0 4426.7 4432.8 4441.1 4469.2 5096.2 5111.7 5111.9 5115.1 5180.5 4307.4 4325.1 4328.0 4350.9 4354.6 4470.6 4536.8 4538.8 4554.5 4561.5 4735.1 4768.1 4791.0 4795.3 4824.1 5104.2 5104.7 5129.4 5129.5 5165.2 4683.6 4730.1 4760.0 4763.2 4799.8 4987.9 5023.4 5042.5 5049.4 5097.3 5084.6 5126.7 5131.6 5138.2 5170.3 4831.9 4952.0 5000.0 5028.0 5033.8 4869.3 4908.8 4922.4 4925.3 4927.9 4860.7 4884.6 4893.5 4960.7 4982.8 5059.8 5072.3 5079.1 5090.5 5111.6 4864.2 4883.2 4923.7 4924.0 4926.1 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#1] ext.html Cycles:180 Average:45054.57 Median:19187.52 stddev:78747.75 (410.4%) stddev-sans-first:78897.69 12:52:12 INFO - PROCESS | 19448 | Values: 525.2 537.2 537.9 540.8 546.5 37614.8 39462.2 39516.8 39539.2 42776.4 38672.4 38920.8 39134.0 39144.4 39310.0 7546.5 7621.7 9615.8 9913.3 9913.4 9778.5 9857.3 9867.4 9872.7 9875.7 9931.8 9970.8 9972.4 9978.1 9978.1 9753.8 9821.6 9870.1 9886.4 9891.8 9647.8 9716.1 9717.5 9718.2 9718.8 36715.0 37004.3 37081.8 37113.3 37239.4 2742.4 2776.7 2861.3 2898.8 3298.0 27396.6 27652.4 27726.8 27745.0 28540.6 3447.3 3497.0 3515.5 3529.8 3530.4 235991.0 237217.0 237632.8 238694.0 238830.0 50863.2 51235.5 51251.0 51360.2 51364.5 50788.5 54426.5 54459.7 54527.2 54589.5 11556.8 13783.7 13987.4 14022.2 14038.5 8645.9 10434.6 10586.6 10636.9 10830.4 16799.7 16833.3 16841.2 16864.6 17231.1 6531.2 6605.4 6613.3 6627.8 6752.6 769.7 844.3 863.1 938.9 955.9 25765.7 26933.6 27184.3 27241.5 27366.6 918.2 922.7 972.0 996.9 1000.3 14246.9 14399.0 14411.6 14570.1 14682.9 340764.0 342709.0 342781.0 344113.1 347625.0 46121.3 46701.0 46967.8 47095.8 47096.0 1121.2 1152.3 1160.1 1165.9 1168.7 25655.6 26202.7 26760.6 26836.2 27217.7 40040.8 40359.8 40396.6 40429.8 40527.8 308911.0 309028.0 310078.0 310284.0 310634.0 23313.2 23751.5 23881.6 23916.3 25020.1 39303.0 39842.8 40104.4 40132.3 40597.8 33804.2 33863.8 33940.2 34230.8 34435.7 33487.7 33748.3 34007.5 34086.7 34776.8 33752.0 33967.5 33989.0 34157.3 34878.0 28550.6 31296.2 31366.5 31412.8 31521.5 24462.8 24537.5 24695.5 24938.0 24983.6 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#2] jquery.html Cycles:180 Average:23435.04 Median:26804.47 stddev:58812.97 (219.4%) stddev-sans-first:58952.41 12:52:12 INFO - PROCESS | 19448 | Values: 348.4 351.9 352.6 364.4 368.8 15489.8 16257.7 16398.6 16425.0 16601.3 15645.8 16436.7 16597.7 16603.6 16651.6 4658.6 5026.9 5062.7 5076.7 5084.4 3633.1 3836.5 4988.7 5087.7 5639.5 5946.8 6013.6 6116.4 6145.8 6146.1 5882.6 6023.4 6039.2 6065.3 6116.9 5258.8 5273.5 5274.6 5281.8 5283.3 20143.3 20717.2 20871.6 21236.4 21383.5 1755.0 1831.5 1845.2 1926.6 2400.5 12279.6 13046.7 13617.6 13677.5 13748.5 1660.7 1688.9 1730.3 1759.3 1773.7 65755.3 66499.7 67456.7 68388.3 70583.3 8946.7 9027.2 9308.6 9345.2 9602.9 12753.3 12780.4 12794.7 12820.2 13081.5 6719.9 7044.6 7202.3 7216.6 7236.9 6683.9 6716.8 6801.0 6940.0 6981.5 5802.3 5993.0 6018.9 6046.4 6109.2 1611.7 1656.3 1705.9 1751.2 1797.2 802.9 844.8 904.0 938.4 942.9 17028.7 17396.3 17640.8 18085.1 18491.4 754.2 824.4 826.3 839.7 858.7 9223.6 10324.8 10330.8 10360.2 10468.4 348547.0 353195.0 354825.0 356348.0 358532.0 77465.0 79523.0 80479.2 82482.6 84039.6 864.3 879.8 908.1 913.7 918.7 14812.1 15184.4 15413.3 15628.8 15845.4 36893.6 37553.6 37928.8 38182.8 38339.2 47057.0 48620.3 51243.5 51517.0 53922.0 6927.9 7073.5 7268.6 7316.8 7336.9 10447.7 10901.3 11208.9 11214.3 11350.7 9721.5 9930.0 9971.5 10008.8 10292.3 10046.1 10158.0 10159.9 10284.5 10436.3 10135.7 10177.0 10278.8 10284.3 10704.9 7329.8 7395.0 7474.9 7492.2 7555.0 7489.0 9292.9 9311.5 9586.6 9666.0 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#3] mootools.html Cycles:180 Average:4531.63 Median:5300.22 stddev:2445.85 (46.1%) stddev-sans-first:2440.79 12:52:12 INFO - PROCESS | 19448 | Values: 1317.7 1362.8 1408.2 1611.0 1638.4 6162.6 6336.2 6524.4 6875.0 6885.8 6719.7 6941.1 6953.0 6954.4 6971.5 2017.6 2040.1 2043.8 2048.0 2058.6 2012.6 2017.6 2024.2 2063.3 2066.7 1997.7 2001.5 2017.6 2022.8 2026.2 1948.2 1962.7 1966.6 1973.9 1979.5 1942.7 1974.5 1981.6 1984.1 1986.8 6755.6 6874.6 6888.6 6935.1 6953.8 4092.8 4206.0 4215.7 4219.3 4236.3 2517.4 2662.7 2729.7 2758.7 2807.1 882.5 911.2 927.4 934.2 947.0 9055.6 9056.8 9089.1 9092.9 9129.4 3650.8 3781.6 3852.0 3863.3 3883.1 8008.5 8009.4 8014.0 8018.1 8028.4 4195.0 4210.4 4212.3 4215.5 4216.7 3302.5 3401.5 3740.8 3836.9 3838.5 3277.9 3280.3 3411.1 3418.3 3426.3 1080.5 1091.4 1108.4 1111.0 1125.1 653.7 787.4 792.9 814.8 827.1 4633.0 4646.6 4653.5 4897.5 4903.7 774.7 799.6 801.1 829.5 830.5 3106.5 3118.5 3174.3 3220.1 3231.5 8060.7 8492.6 8496.2 8502.1 8518.2 8419.2 8433.7 8441.1 8459.6 8459.8 6505.7 6639.2 6642.7 6655.4 6657.4 4484.8 4615.0 4633.2 4903.8 4903.9 7497.9 7637.7 7668.3 7679.7 7697.4 7502.9 7582.9 7607.7 7656.6 7668.3 5221.8 5378.7 5893.0 6102.6 6112.3 6061.4 6214.4 6221.6 6383.7 6385.2 5706.5 5886.0 5936.6 5971.8 6038.7 5779.3 5814.6 5825.4 5887.4 5937.2 5411.3 5474.0 5517.6 5527.9 5535.3 3888.8 3957.7 3958.3 4020.1 4033.6 4000.6 4033.4 4174.3 4214.5 4258.0 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#4] prototype.html Cycles:180 Average:4212.75 Median:4827.22 stddev:1254.48 (26.0%) stddev-sans-first:1222.55 12:52:12 INFO - PROCESS | 19448 | Values: 267.6 268.4 273.8 273.8 275.8 4948.9 4987.8 5007.2 5016.4 5032.3 4920.2 4924.9 4927.0 4931.6 4944.4 3557.9 3643.1 3668.7 3769.4 3788.2 3760.7 3771.4 3774.8 3777.7 3789.3 3728.2 3747.0 3747.5 3752.6 3776.9 3665.9 3693.9 3764.1 3771.2 3777.3 3212.3 3240.7 3249.3 3259.4 3271.2 4808.5 4813.8 4822.2 4833.7 4833.9 4301.0 4308.9 4309.7 4311.7 4318.2 4905.7 5131.6 5141.3 5146.2 5182.7 3580.4 3584.7 3584.7 3590.3 3594.7 5380.4 5385.5 5392.6 5394.8 5419.9 3397.4 3517.8 3681.4 3683.3 3698.2 3622.3 3623.8 3633.4 3637.1 3642.3 4206.0 4212.2 4214.4 4220.0 4225.5 5120.4 5157.9 5158.3 5161.7 5175.6 1184.7 1216.7 1230.5 1231.3 1234.5 793.7 816.2 829.2 829.8 832.4 4341.0 4366.8 4519.1 4527.2 4630.2 5366.3 5373.9 5386.9 5388.1 5388.4 4667.4 4668.5 4670.3 4675.3 4677.4 2713.7 2727.7 2748.7 2756.4 2796.6 4831.0 4837.0 4848.4 4850.0 4853.4 5081.4 5330.2 5346.6 5357.7 5360.2 4817.5 4824.4 4825.5 4837.0 4847.7 5190.6 5194.8 5202.9 5235.6 5239.8 4919.9 5006.9 5095.2 5113.9 5141.9 4778.5 4795.8 4808.9 4825.7 4828.7 3596.4 3610.8 3617.3 3627.4 3629.3 5005.6 5209.6 5210.4 5214.8 5222.1 4996.8 5013.0 5026.4 5027.4 5041.3 5016.9 5057.4 5083.5 5104.9 5124.5 4737.5 4980.5 4985.1 4997.8 5009.8 5012.8 5027.8 5098.9 5140.0 5292.5 5134.2 5138.2 5140.0 5160.4 5163.5 12:52:12 INFO - PROCESS | 19448 | 12:52:12 INFO - PROCESS | 19448 | [#5] yui.html Cycles:180 Average:14364.87 Median:49795.00 stddev:17396.97 (34.9%) stddev-sans-first:17415.20 12:52:12 INFO - PROCESS | 19448 | Values: 629.2 630.0 666.8 714.9 730.3 11597.3 12433.4 12476.8 12514.6 12534.7 12251.2 12255.8 12322.5 12390.9 12427.1 743.8 755.7 756.7 757.0 758.9 606.4 625.1 730.1 756.2 760.8 793.6 801.6 801.6 802.0 804.5 797.6 797.7 798.1 799.3 799.4 587.1 587.8 588.2 588.4 588.8 12724.6 13056.4 13081.2 13128.7 13140.5 13318.3 13493.0 13690.2 13801.9 13827.1 9898.2 10011.5 10030.8 10294.8 10359.2 3204.5 3223.4 3255.0 3281.6 3284.1 61102.4 61272.7 61609.0 62002.7 62815.7 8880.9 9102.5 9312.5 9360.3 9447.6 18445.7 18550.8 18572.7 18648.3 18908.1 6200.8 6231.3 6273.7 6359.2 6403.3 3345.4 3466.2 3468.3 3514.6 3582.5 2659.7 2771.4 2777.5 2781.7 2784.8 413.1 413.6 423.7 430.8 431.4 611.6 618.6 625.9 631.7 639.2 7990.6 8165.2 8312.5 8538.4 8549.9 516.4 553.7 572.9 615.6 619.6 3655.9 3779.7 3781.7 3879.2 3899.7 52260.5 52924.2 53007.0 54840.7 55123.0 52931.0 53397.0 54623.7 54715.2 55118.7 49811.0 50028.0 50805.2 50818.7 52519.7 8404.0 8417.0 8433.8 8511.1 8596.7 35746.6 36103.6 36230.8 36701.3 38364.6 43502.3 48932.0 49779.0 50048.0 50436.7 10270.2 10321.5 10407.4 10610.8 11211.2 12787.2 12930.5 12978.0 13030.7 13419.6 11620.9 12159.1 12525.7 12590.4 13065.3 11779.0 11862.3 12103.2 12194.6 12478.3 11744.8 12652.6 12681.3 12734.9 12773.8 9280.4 9315.4 9531.9 9547.9 9653.5 9299.0 10085.6 10110.6 10203.8 10394.5 12:52:12 INFO - PROCESS | 19448 | -------- Summary: end -------- 12:52:12 INFO - PROCESS | 19448 | 12:52:13 INFO - TEST-INFO | 19448: exit 0 12:52:13 INFO - TEST-OK | dromaeo_css | took 1120124ms 12:52:13 INFO - TEST-START | kraken 12:52:13 INFO - operating with platform_type : linux_ 12:52:13 INFO - Initialising browser for kraken test... 12:52:13 INFO - TEST-INFO | started process 19806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvSWGj/profile http://localhost:58491/getInfo.html) 12:52:18 INFO - PROCESS | 19806 | __metrics Screen width/height:1600/1200 12:52:18 INFO - PROCESS | 19806 | colorDepth:24 12:52:18 INFO - PROCESS | 19806 | Browser inner width/height: 1024/697 12:52:18 INFO - PROCESS | 19806 | __metrics 12:52:18 ERROR - PROCESS | 19806 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 12:52:19 INFO - TEST-INFO | 19806: exit 0 12:52:19 INFO - Browser initialized. 12:52:19 INFO - Running cycle 1/1 for kraken test... 12:52:19 INFO - TEST-INFO | started process 19930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvSWGj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:32 INFO - PROCESS | 19930 | RSS: Main: 187453440 12:52:32 INFO - PROCESS | 19930 | 12:52:35 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58491/tests/kraken/driver.html?testName=audio-beat-detection) 12:52:36 INFO - PROCESS | 19930 | RSS: Main: 199520256 12:52:36 INFO - PROCESS | 19930 | 12:52:38 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58491/tests/kraken/driver.html?testName=audio-dft) 12:52:39 INFO - PROCESS | 19930 | RSS: Main: 198213632 12:52:39 INFO - PROCESS | 19930 | 12:52:42 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58491/tests/kraken/driver.html?testName=audio-fft) 12:52:43 INFO - PROCESS | 19930 | RSS: Main: 194924544 12:52:43 INFO - PROCESS | 19930 | 12:52:45 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58491/tests/kraken/driver.html?testName=audio-oscillator) 12:52:45 INFO - PROCESS | 19930 | RSS: Main: 195383296 12:52:45 INFO - PROCESS | 19930 | 12:52:48 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:48 INFO - PROCESS | 19930 | RSS: Main: 195153920 12:52:48 INFO - PROCESS | 19930 | 12:52:51 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58491/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:52 INFO - PROCESS | 19930 | RSS: Main: 200679424 12:52:52 INFO - PROCESS | 19930 | 12:52:56 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58491/tests/kraken/driver.html?testName=imaging-desaturate) 12:52:56 INFO - PROCESS | 19930 | RSS: Main: 196698112 12:52:56 INFO - PROCESS | 19930 | 12:52:59 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58491/tests/kraken/driver.html?testName=json-parse-financial) 12:53:00 INFO - PROCESS | 19930 | RSS: Main: 197840896 12:53:00 INFO - PROCESS | 19930 | 12:53:01 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:53:02 INFO - PROCESS | 19930 | RSS: Main: 197996544 12:53:02 INFO - PROCESS | 19930 | 12:53:04 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:53:05 INFO - PROCESS | 19930 | RSS: Main: 198078464 12:53:05 INFO - PROCESS | 19930 | 12:53:07 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:53:07 INFO - PROCESS | 19930 | RSS: Main: 198565888 12:53:07 INFO - PROCESS | 19930 | 12:53:10 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:53:11 INFO - PROCESS | 19930 | RSS: Main: 198610944 12:53:11 INFO - PROCESS | 19930 | 12:53:14 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:53:15 INFO - PROCESS | 19930 | RSS: Main: 202719232 12:53:15 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | Cycle 1(1): loaded http://localhost:58491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58491/tests/kraken/driver.html?testName=ai-astar) 12:53:17 INFO - PROCESS | 19930 | RSS: Main: 204488704 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | __start_tp_report 12:53:17 INFO - PROCESS | 19930 | _x_x_mozilla_page_load 12:53:17 INFO - PROCESS | 19930 | _x_x_mozilla_page_load_details 12:53:17 INFO - PROCESS | 19930 | |i|pagename|runs| 12:53:17 INFO - PROCESS | 19930 | |0;ai-astar;111;121;119;120;120;119;119;120;119;118 12:53:17 INFO - PROCESS | 19930 | |1;audio-beat-detection;164;134;138;167;134;130;132;131;151;131 12:53:17 INFO - PROCESS | 19930 | |2;audio-dft;167;177;164;163;164;162;163;164;164;166 12:53:17 INFO - PROCESS | 19930 | |3;audio-fft;77;76;77;111;78;77;76;77;94;78 12:53:17 INFO - PROCESS | 19930 | |4;audio-oscillator;86;85;100;84;84;84;98;83;84;102 12:53:17 INFO - PROCESS | 19930 | |5;imaging-gaussian-blur;117;118;117;120;118;118;120;119;119;119 12:53:17 INFO - PROCESS | 19930 | |6;imaging-darkroom;152;149;149;150;149;150;148;150;150;149 12:53:17 INFO - PROCESS | 19930 | |7;imaging-desaturate;98;98;97;97;97;96;96;96;96;96 12:53:17 INFO - PROCESS | 19930 | |8;json-parse-financial;64;65;65;65;69;65;64;66;65;65 12:53:17 INFO - PROCESS | 19930 | |9;json-stringify-tinderbox;67;66;66;66;67;66;69;66;67;67 12:53:17 INFO - PROCESS | 19930 | |10;stanford-crypto-aes;87;87;87;89;86;86;91;86;86;88 12:53:17 INFO - PROCESS | 19930 | |11;stanford-crypto-ccm;145;161;158;151;149;155;148;146;248;148 12:53:17 INFO - PROCESS | 19930 | |12;stanford-crypto-pbkdf2;182;184;190;181;179;185;189;186;183;180 12:53:17 INFO - PROCESS | 19930 | |13;stanford-crypto-sha256-iterative;74;74;82;75;73;73;72;71;72;89 12:53:17 INFO - PROCESS | 19930 | __end_tp_report 12:53:17 INFO - PROCESS | 19930 | __start_cc_report 12:53:17 INFO - PROCESS | 19930 | _x_x_mozilla_cycle_collect,899 12:53:17 INFO - PROCESS | 19930 | __end_cc_report 12:53:17 INFO - PROCESS | 19930 | __startTimestamp1480711997544__endTimestamp 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | ------- Summary: start ------- 12:53:17 INFO - PROCESS | 19930 | Number of tests: 14 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#0] ai-astar Cycles:10 Average:118.60 Median:119.50 stddev:2.80 (2.3%) stddev-sans-first:0.88 12:53:17 INFO - PROCESS | 19930 | Values: 111.0 121.0 119.0 120.0 120.0 119.0 119.0 120.0 119.0 118.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:136.00 stddev:14.20 (10.4%) stddev-sans-first:12.43 12:53:17 INFO - PROCESS | 19930 | Values: 164.0 134.0 138.0 167.0 134.0 130.0 132.0 131.0 151.0 131.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:4.33 (2.6%) stddev-sans-first:4.55 12:53:17 INFO - PROCESS | 19930 | Values: 167.0 177.0 164.0 163.0 164.0 162.0 163.0 164.0 164.0 166.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:11.49 (14.9%) stddev-sans-first:12.04 12:53:17 INFO - PROCESS | 19930 | Values: 77.0 76.0 77.0 111.0 78.0 77.0 76.0 77.0 94.0 78.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:84.00 stddev:7.69 (9.2%) stddev-sans-first:8.08 12:53:17 INFO - PROCESS | 19930 | Values: 86.0 85.0 100.0 84.0 84.0 84.0 98.0 83.0 84.0 102.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 12:53:17 INFO - PROCESS | 19930 | Values: 117.0 118.0 117.0 120.0 118.0 118.0 120.0 119.0 119.0 119.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.07 (0.7%) stddev-sans-first:0.71 12:53:17 INFO - PROCESS | 19930 | Values: 152.0 149.0 149.0 150.0 149.0 150.0 148.0 150.0 150.0 149.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.73 12:53:17 INFO - PROCESS | 19930 | Values: 98.0 98.0 97.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.42 12:53:17 INFO - PROCESS | 19930 | Values: 64.0 65.0 65.0 65.0 69.0 65.0 64.0 66.0 65.0 65.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 12:53:17 INFO - PROCESS | 19930 | Values: 67.0 66.0 66.0 66.0 67.0 66.0 69.0 66.0 67.0 67.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.64 (1.9%) stddev-sans-first:1.73 12:53:17 INFO - PROCESS | 19930 | Values: 87.0 87.0 87.0 89.0 86.0 86.0 91.0 86.0 86.0 88.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:153.00 stddev:31.05 (20.3%) stddev-sans-first:32.40 12:53:17 INFO - PROCESS | 19930 | Values: 145.0 161.0 158.0 151.0 149.0 155.0 148.0 146.0 248.0 148.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:184.50 stddev:3.67 (2.0%) stddev-sans-first:3.82 12:53:17 INFO - PROCESS | 19930 | Values: 182.0 184.0 190.0 181.0 179.0 185.0 189.0 186.0 183.0 180.0 12:53:17 INFO - PROCESS | 19930 | 12:53:17 INFO - PROCESS | 19930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:74.00 stddev:5.64 (7.6%) stddev-sans-first:5.96 12:53:17 INFO - PROCESS | 19930 | Values: 74.0 74.0 82.0 75.0 73.0 73.0 72.0 71.0 72.0 89.0 12:53:17 INFO - PROCESS | 19930 | -------- Summary: end -------- 12:53:17 INFO - PROCESS | 19930 | 12:53:18 INFO - TEST-INFO | 19930: exit 0 12:53:18 INFO - TEST-OK | kraken | took 65362ms 12:53:18 INFO - SUITE-END | took 1185s 12:53:19 INFO - Completed test suite (00:19:45) 12:53:19 INFO - javascript benchmark 12:53:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6214.735138517588, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.433184699367, 2588.715241323454, 2641.4981153580807, 2645.801564882634, 2669.359353755099, 4647.814087436498, 4791.880202994927, 4818.036392721457, 4829.420469543656, 4838.709677419357, 4704.600108990731, 4749.311349854269, 4765.237561990082, 4770.212914869043, 4841.2496063110275, 4259.041715613986, 4268.87193384199, 4325.956740432603, 4382.12357528494, 4418.9337159942625, 4297.269464191095, 4389.122175564884, 4401.713888597247, 4425.645948324142, 4438.334249862531, 4293.0, 4384.18892504886, 4409.603135717769, 4414.757188354639, 4442.022754993896, 4314.546972567867, 4362.36745671879, 4377.146456440963, 4378.365137055141, 4395.824167033346, 4318.157959197958, 4350.912981740347, 4354.455693038371, 4355.194289056503, 4361.084172323815, 4730.479647238801, 4735.052989402134, 4741.620670346364, 4761.571458568711, 4792.257200133985, 5091.541761241469, 5092.388913330387, 5101.8724531887, 5117.257997590328, 5153.2785410042625, 5128.948710512885, 5147.588192944556, 5157.097507936133, 5168.9224661630105, 5182.896342073137, 4678.532146785295, 4693.95306046942, 4726.881827954328, 4744.810207591727, 4794.784234709412, 5216.739163041832, 5224.843254702365, 5235.842924712265, 5241.580673546107, 5283.260343551906, 4978.8257410990445, 5008.12357837377, 5022.196448568212, 5026.421961474477, 5075.3148324975655, 4936.0, 4998.2002879539095, 5098.643094983316, 5100.744962751847, 5149.716765577854, 5005.049040682259, 5018.799248030111, 5027.421846487628, 5090.440051594322, 5129.333186685707, 5035.79856805731, 5064.316317297192, 5097.923531147036, 5100.336956195671, 5107.080725469377, 4229.2598795210715, 4335.6965012449455, 4355.651547876162, 4361.956380436155, 4408.294672852392, 3682.815859207029, 3726.8136593170234, 3751.0622344413896, 3751.268502642013, 3835.252125835491, 4400.031992961543, 4426.690131690815, 4432.82268709248, 4441.11177764442, 4469.173202957463, 5096.159133742891, 5111.693298402108, 5111.897762044739, 5115.130427827278, 5180.456052114474, 4307.375430562551, 4325.070109926381, 4328.04782947751, 4350.912981740411, 4354.586314300136, 4470.575295346936, 4536.818527258939, 4538.818447262072, 4554.4990051094355, 4561.521040290721, 4735.100330937111, 4768.070226305837, 4790.952090479051, 4795.328653988514, 4824.107540105092, 5104.2088476286235, 5104.69371837691, 5129.358830146231, 5129.538341549279, 5165.173572228426, 4683.555062269079, 4730.053989202104, 4760.0, 4763.214069678603, 4799.760011999456, 4987.850364489072, 5023.447420783637, 5042.520960508746, 5049.368828896388, 5097.286379906742, 5084.5932325414615, 5126.6923984561045, 5131.640785145004, 5138.177891537336, 5170.276161337491, 4831.903361932812, 4952.0, 4999.950000500094, 5028.044671512401, 5033.798648054037, 4869.342638743724, 4908.7545622719435, 4922.384701912261, 4925.285833554043, 4927.926081108714, 4860.684055536379, 4884.609231261562, 4893.486183950634, 4960.70235785854, 4982.800687972441, 5059.797608095782, 5072.28987941681, 5079.11115554769, 5090.4655011223285, 5111.565516930954, 4864.246041863516, 4883.194272944925, 4923.679960802537, 4923.950760492349, 4926.064047830901], "value": 4673.47204486368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.2226704477373, 537.231758585223, 537.9193121031846, 540.7917951588637, 546.4808431989611, 37614.81192594037, 39462.210755784865, 39516.80241598795, 39539.20921581574, 42776.3583546247, 38672.41991370132, 38920.80539597305, 39134.0, 39144.41283380752, 39310.01724956877, 7546.4717469777, 7621.695132194705, 9615.807683846353, 9913.256505762096, 9913.405195688245, 9778.511074446285, 9857.260705447085, 9867.407955522656, 9872.703818885446, 9875.654352097677, 9931.801363972716, 9970.800583988315, 9972.351797133164, 9978.052085051944, 9978.101970822625, 9753.82954045519, 9821.558029888636, 9870.062344077302, 9886.406815591088, 9891.752706182404, 9647.807043859153, 9716.076972687653, 9717.514124293757, 9718.173955213744, 9718.805623887554, 36715.0, 37004.25991480182, 37081.81459092687, 37113.25773484542, 37239.441408378894, 2742.3829638331417, 2776.7223277672274, 2861.2989817494845, 2898.826070435781, 3297.9835100824585, 27396.58905116425, 27652.446951060865, 27726.808362195578, 27745.0, 28540.571891421645, 3447.3277710846396, 3497.0452401052585, 3515.490253913194, 3529.770564913272, 3530.3645343838098, 235991.0, 237217.0, 237632.81183594145, 238694.0, 238830.0, 50863.23705144426, 51235.487645123816, 51251.0, 51360.229596556084, 51364.48635513597, 50788.49211507911, 54426.45573544293, 54459.72770136203, 54527.182092268646, 54589.45410545844, 11556.76886462266, 13783.655408614664, 13987.37056832445, 14022.22877741734, 14038.508652197124, 8645.870311945326, 10434.582616695247, 10586.629467968583, 10636.946815265874, 10830.40432776205, 16799.748003779954, 16833.32666693343, 16841.242144103544, 16864.578385540215, 17231.138443077794, 6531.216254049449, 6605.372489613479, 6613.3056029117215, 6627.768028118992, 6752.5948443093575, 769.7190525458279, 844.2992316377392, 863.0592654007162, 938.9108034736689, 955.9091886270793, 25765.74234257671, 26933.595996060074, 27184.340675710897, 27241.455170896472, 27366.589501157498, 918.2332752151895, 922.7462447826902, 972.0, 996.8903420623726, 1000.2698030437675, 14246.928765356313, 14399.0, 14411.567652970427, 14570.125792452487, 14682.853171468149, 340764.0, 342709.0, 342781.0, 344113.1475537689, 347625.0, 46121.308180377324, 46701.0, 46967.76516117398, 47095.76452117786, 47096.0, 1121.1927412263158, 1152.274067337572, 1160.0893298760432, 1165.930044197351, 1168.6902970712767, 25655.615165772902, 26202.73797262003, 26760.59859102154, 26836.194914151827, 27217.72782272231, 40040.799796000836, 40359.79820100881, 40396.596034039285, 40429.79785101055, 40527.79736101301, 308911.0, 309028.0, 310078.0, 310284.0, 310634.0, 23313.184038558567, 23751.52496950086, 23881.641775373035, 23916.28251152468, 25020.124295650294, 39303.0, 39842.80471585857, 40104.39843402409, 40132.266964134586, 40597.79701101476, 33804.154896127795, 33863.83068084644, 33940.15149621279, 34230.82884585561, 34435.65564344324, 33487.66512334943, 33748.325033499685, 34007.4898876522, 34086.65913340835, 34776.82611587027, 33752.0, 33967.4904876432, 33989.0, 34157.31685366329, 34878.0, 28550.57174142348, 31296.21759456032, 31366.52950205703, 31412.842935785175, 31521.52717709282, 24462.75537244605, 24537.509249815263, 24695.50608987846, 24938.0, 24983.625245620966], "value": 17375.935078951294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.44597090625916, 351.8821194899708, 352.63326140813547, 364.4151137424435, 368.84508506427295, 15489.767653485193, 16257.674846503063, 16398.590035249126, 16424.999999999985, 16601.252943617535, 15645.843541564582, 16436.671266574693, 16597.66804663906, 16603.584910377245, 16651.583710407245, 4658.557437043484, 5026.874328141789, 5062.670926389791, 5076.746162691869, 5084.389873215219, 3633.073566240618, 3836.462895194675, 4988.675736077162, 5087.694738315695, 5639.464250896179, 5946.821595352147, 6013.639181649115, 6116.357782432825, 6145.784897528587, 6146.078088286748, 5882.617629854046, 6023.397660233985, 6039.184710064151, 6065.302490213638, 6116.938830611703, 5258.789648414097, 5273.525382715574, 5274.630775845692, 5281.762320695578, 5283.313169288006, 20143.294984675613, 20717.171313147457, 20871.58256834855, 21236.407269454852, 21383.465413364636, 1754.9824501755074, 1831.532959095422, 1845.1881172284152, 1926.566522532433, 2400.5198960207854, 12279.570215042431, 13046.673833154153, 13617.591472255848, 13677.452901883913, 13748.518801841887, 1660.7093758592318, 1688.8902221355572, 1730.3338214787273, 1759.289135992457, 1773.6807374672553, 65755.3424465754, 66499.66750166267, 67456.6627166861, 68388.3161168392, 70583.29416705818, 8946.68686595966, 9027.187553120251, 9308.581113849894, 9345.158935695685, 9602.90397096034, 12753.298568578632, 12780.360981950866, 12794.744105118032, 12820.166689165175, 13081.542146024844, 6719.883236780496, 7044.647767611599, 7202.279772022861, 7216.5670059796585, 7236.9276307237305, 6683.866322673519, 6716.832079197961, 6801.0, 6939.965300173467, 6981.511294209458, 5802.33273173582, 5992.970035149883, 6018.909716354171, 6046.3651316612, 6109.236345456818, 1611.6534944986884, 1656.2960741684976, 1705.9232334544974, 1751.211954620426, 1797.1553369916119, 802.9357651387875, 844.7550210438903, 903.9728808135767, 938.4134915677702, 942.8868535775614, 17028.659426811642, 17396.3041478342, 17640.823591763918, 18085.095745212686, 18491.352802651843, 754.1741792736944, 824.4393812207636, 826.273089243472, 839.6599377252222, 858.7080392666523, 9223.584938677775, 10324.845127323097, 10330.79868736206, 10360.222983276284, 10468.424236666904, 348547.0, 353195.0, 354825.0, 356348.0, 358532.0, 77465.0, 79523.0, 80479.19520804835, 82482.58758706288, 84039.5798021006, 864.3387808326635, 879.7580665316962, 908.1281969309405, 913.7030465098869, 918.7289749523907, 14812.074430323988, 15184.392624294904, 15413.306401212196, 15628.765568516708, 15845.445409410615, 36893.63106368902, 37553.6244637561, 37928.810355948044, 38182.809085954395, 38339.23321533498, 47057.0, 48620.27069594029, 51243.48756512387, 51517.0, 53922.0, 6927.89608155868, 7073.50485466033, 7268.563886166847, 7316.780496585111, 7336.860670193876, 10447.738806529898, 10901.291416057931, 11208.943955280172, 11214.271072380268, 11350.659480215607, 9721.4653194075, 9929.950350248202, 9971.45157016371, 10008.84986725185, 10292.330998485373, 10046.146077583488, 10158.0, 10159.898401015895, 10284.485775711035, 10436.321639093434, 10135.695929122137, 10177.0, 10278.845817312897, 10284.2801003932, 10704.89295107039, 7329.780106596811, 7394.963025184839, 7474.925250747423, 7492.213317601573, 7555.0, 7488.9625551871895, 9292.907070929205, 9311.534423278945, 9586.568604412958, 9665.951670241604], "value": 8223.63400086891, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.683755898584, 1362.7887677410001, 1408.2184387664847, 1611.0333799720177, 1638.3610391947143, 6162.568620196588, 6336.239651241846, 6524.445422139118, 6874.965625171873, 6885.827854303639, 6719.697613607387, 6941.132358455193, 6952.96523517383, 6954.44364450844, 6971.477139214554, 2017.6166528359638, 2040.1329434990143, 2043.8467114966363, 2047.9795202048012, 2058.5985732782115, 2012.5773587546632, 2017.6469117904307, 2024.2409096588779, 2063.3397312859893, 2066.6590012647894, 1997.6703843865744, 2001.539645881441, 2017.576308975117, 2022.8381729461607, 2026.2097781865084, 1948.2109745553073, 1962.6859702447682, 1966.5575245569776, 1973.851961102923, 1979.4853338132045, 1942.7377304063912, 1974.5162435203467, 1981.564055907698, 1984.1468168687459, 1986.7615886093618, 6755.594664320157, 6874.553154045021, 6888.621125838077, 6935.098437203182, 6953.826154346131, 4092.7544347339253, 4206.0, 4215.725977811432, 4219.261629214875, 4236.301010333292, 2517.358073691197, 2662.720414356484, 2729.713380095101, 2758.724127587245, 2807.087696498646, 882.5057967538199, 911.1571796088658, 927.4064598656865, 934.1545900959643, 947.0340252942029, 9055.592498337524, 9056.818863622691, 9089.136532029446, 9092.909070909338, 9129.360944733939, 3650.762700424517, 3781.5840257571645, 3852.0, 3863.343231650626, 3883.1457079442475, 8008.479448835807, 8009.4393392463135, 8014.0, 8018.077921039038, 8028.438009339407, 4195.0, 4210.431591735138, 4212.283911734951, 4215.494140703136, 4216.704830661824, 3302.5046243063734, 3401.5067815166663, 3740.831662575191, 3836.865709700147, 3838.4626152338697, 3277.885274015398, 3280.327532855759, 3411.1301618087227, 3418.3163367326633, 3426.3318652862454, 1080.5407701726735, 1091.4051841746268, 1108.3737688206138, 1111.0223003756641, 1125.071815752008, 653.7123665587221, 787.3504358903928, 792.944493885434, 814.8085199978001, 827.1356432527903, 4632.953670463252, 4646.605038571692, 4653.534646535387, 4897.510248975145, 4903.656744027955, 774.6823802241166, 799.6121880887765, 801.0587559617543, 829.531314807132, 830.4560512864084, 3106.4718997770433, 3118.547810567455, 3174.3016536361965, 3220.0661808075397, 3231.5475833383343, 8060.677572897136, 8492.575371231414, 8496.192861678132, 8502.149785021573, 8518.233358997595, 8419.242268195769, 8433.662653493915, 8441.113683063313, 8459.577021149042, 8459.788505287293, 6505.674716264262, 6639.236487803868, 6642.701078451385, 6655.43428808547, 6657.434118099919, 4484.798184081659, 4614.976925115353, 4633.166030114612, 4903.77932993009, 4903.901921961612, 7497.850042999218, 7637.732679356196, 7668.271514206142, 7679.654415551202, 7697.384209263358, 7502.887456688045, 7582.886256706264, 7607.695692172472, 7656.578888161204, 7668.348190403655, 5221.791128354823, 5378.650387724785, 5892.970535147297, 6102.572819902742, 6112.32764395925, 6061.39386061408, 6214.378562143749, 6221.595596286227, 6383.744650213939, 6385.23377194721, 5706.543476521952, 5885.970570147122, 5936.554758393224, 5971.761129554943, 6038.69806509664, 5779.306483222041, 5814.5639077068545, 5825.446582574648, 5887.41125887425, 5937.198478205387, 5411.2965314508865, 5473.972630136824, 5517.613767036269, 5527.8894422112135, 5535.25274087993, 3888.8250028748207, 3957.703172262034, 3958.267720471722, 4020.0954785173103, 4033.5764744701382, 4000.6399424051974, 4033.3949907514107, 4174.311238645711, 4214.515330737005, 4258.041940563348], "value": 3714.930453447749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.5825711889453, 268.40682092575406, 273.7563568424103, 273.7727686020603, 275.7862656441258, 4948.876278093049, 4987.800487980481, 5007.248912663098, 5016.372953380827, 5032.295478632995, 4920.212765957447, 4924.926126108111, 4926.9753651231695, 4931.580815630676, 4944.431390390107, 3557.8576856925692, 3643.143861192618, 3668.7248456365746, 3769.396896496561, 3788.2423515296914, 3760.736748427611, 3771.4154306082464, 3774.77351358918, 3777.7355585108917, 3789.2989796887528, 3728.1798004439115, 3746.9625303746884, 3747.4566187902874, 3752.6059763724825, 3776.8678096266635, 3665.9450108248398, 3693.8707145249787, 3764.1342491227033, 3771.1703425246537, 3777.338965680995, 3212.3254116635535, 3240.708336249725, 3249.2689144942437, 3259.3807176636365, 3271.2312606537444, 4808.519148085164, 4813.78337974792, 4822.1561226785525, 4833.734144622044, 4833.879153021167, 4300.956990430087, 4308.913821723548, 4309.698321117523, 4311.676624253194, 4318.179545886272, 4905.681130726492, 5131.640785145041, 5141.280220769096, 5146.176611742103, 5182.663126896739, 3580.3913334733156, 3584.731145164097, 3584.731145164123, 3590.317839610466, 3594.748367614268, 5380.399758206755, 5385.542228910547, 5392.649477783932, 5394.7842086316505, 5419.943111093377, 3397.371486275047, 3517.806520641338, 3681.4293784463453, 3683.324087540163, 3698.167912219783, 3622.347977364047, 3623.80069096197, 3633.364161271767, 3637.127089498554, 3642.25333806569, 4205.957940420618, 4212.157568486254, 4214.388913607571, 4219.9578004220175, 4225.450691410097, 5120.436751957282, 5157.922631160461, 5158.252053452304, 5161.741912904415, 5175.560077393464, 1184.6505280942142, 1216.7323188898429, 1230.5200971621075, 1231.2920070959235, 1234.5370486067725, 793.6507936507844, 816.1715858403725, 829.2163905109613, 829.7759604906641, 832.3715594726065, 4341.0, 4366.755474689761, 4519.141363140992, 4527.230370836965, 4630.189716799547, 5366.302380690563, 5373.898350838069, 5386.946130538723, 5388.057090009311, 5388.38033626138, 4667.369905062773, 4668.533146685304, 4670.276107203389, 4675.298705194248, 4677.368555245066, 2713.66079240095, 2727.677076617839, 2748.69764325924, 2756.393593409487, 2796.5944937983877, 4831.0, 4836.992648051019, 4848.393950756155, 4849.975750121297, 4853.432726945692, 5081.415637201695, 5330.227117068003, 5346.599005074635, 5357.705326207096, 5360.249565060894, 4817.470078291385, 4824.445188803333, 4825.541573550507, 4837.032593481318, 4847.684900481458, 5190.598538394688, 5194.844154675366, 5202.921956170585, 5235.581153507634, 5239.764210610456, 4919.868430260988, 5006.924896126634, 5095.184770436712, 5113.897722045613, 5141.871453213699, 4778.4982576830325, 4795.848996240947, 4808.903821923612, 4825.697061793226, 4828.734419606955, 3596.3706351387877, 3610.7833529988284, 3617.330793803155, 3627.4014787560814, 3629.274145171029, 5005.649604527648, 5209.635325527177, 5210.400803907448, 5214.791408343775, 5222.086134926297, 4996.825111121093, 5013.0, 5026.44709082008, 5027.446980832033, 5041.344625198701, 5016.899662006666, 5057.443681195139, 5083.534485774322, 5104.872378190426, 5124.487551244994, 4737.455192652889, 4980.513640451626, 4985.077760614298, 4997.750112494434, 5009.799608015638, 5012.824551140692, 5027.7737501813235, 5098.898022039612, 5140.0, 5292.465185096433, 5134.176203088361, 5138.152204886152, 5139.974300128475, 5160.432352441304, 5163.483651634807], "value": 3800.164648455692, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.1663545801814, 629.9905501417479, 666.7666316789122, 714.8677494663488, 730.2697302697301, 11597.3041617503, 12433.440495177727, 12476.750464990695, 12514.624561263165, 12534.749305013895, 12251.20367176133, 12255.816162757566, 12322.507099716024, 12390.876091239084, 12427.067969902248, 743.7805847275054, 755.7128291249318, 756.6897571995482, 757.0158793568366, 758.9127250366223, 606.3814908793029, 625.1466747889144, 730.1493759769888, 756.2097607999654, 760.8174038230812, 793.6428607126787, 801.5551368990208, 801.587182600961, 801.9599020049003, 804.5454318310136, 797.6251161953901, 797.7447216890597, 798.0543056478064, 799.3405440511601, 799.3684988858853, 587.0577722755003, 587.8089620873234, 588.2470437839572, 588.3792598808255, 588.8115802943059, 12724.554640587536, 13056.412461439162, 13081.215127092404, 13128.737425251442, 13140.540081097115, 13318.269754700263, 13493.0, 13690.178589284675, 13801.861981380258, 13827.101238419471, 9898.158656514204, 10011.549480273332, 10030.799384012353, 10294.845577316346, 10359.223058270585, 3204.4872820348633, 3223.403670320998, 3255.0, 3281.5569898063695, 3284.096873359845, 61102.388976110116, 61272.693636531534, 61609.0, 62002.689986549776, 62815.685921570555, 8880.8667869982, 9102.453852768855, 9312.48781317034, 9360.297977651704, 9447.574859131355, 18445.7233141503, 18550.814491855177, 18572.721409178874, 18648.347307844433, 18908.149133289036, 6200.81397558074, 6231.3145553989025, 6273.7176827042895, 6359.2368915729485, 6403.295637479873, 3345.4145524533596, 3466.2374277658873, 3468.2890007548895, 3514.5606799150105, 3582.4805403216387, 2659.6675415573054, 2771.362586605052, 2777.472280266743, 2781.680106787705, 2784.8189867658944, 413.128299288501, 413.5616246778425, 423.69070578477266, 430.7759964818277, 431.37450696490214, 611.6421893192532, 618.5515501261549, 625.9342769009279, 631.709413669717, 639.2105749399487, 7990.600469976478, 8165.183481651906, 8312.459690120122, 8538.44500107491, 8549.914500854911, 516.377764793423, 553.7098560354365, 572.8510587247346, 615.5875563372551, 619.6189343553772, 3655.8720444784303, 3779.7132734695665, 3781.716371272166, 3879.165979314461, 3899.6880249579967, 52260.477395225564, 52924.206136907975, 53007.0, 54840.72579637076, 55123.0, 52931.0, 53397.0, 54623.726881365335, 54715.17927231095, 55118.72440637771, 49811.0, 50028.0, 50805.23792143121, 50818.74590627023, 52519.73740131275, 8403.957980210304, 8417.0, 8433.789155271168, 8511.148885111439, 8596.65613375483, 35746.64253357433, 36103.63896361003, 36230.818845905604, 36701.26597468089, 38364.61635383611, 43502.34746478868, 48932.0, 49779.0, 50048.0, 50436.747816260686, 10270.229732769923, 10321.48392580383, 10407.427591482237, 10610.840837387292, 11211.159163062639, 12787.232766034067, 12930.482780688668, 12978.0, 13030.739385212053, 13419.597412077654, 11620.941895290807, 12159.088068394729, 12525.686857828627, 12590.370481475706, 13065.346732663518, 11779.0, 11862.347570883685, 12103.152779305365, 12194.634160975185, 12478.313692746622, 11744.823827642764, 12652.590480850156, 12681.30252836066, 12734.872651273368, 12773.808392873929, 9280.396774209656, 9315.39449935752, 9531.904680953101, 9547.904520954979, 9653.517324133625, 9299.0, 10085.596576137166, 10110.595576176871, 10203.795924081625, 10394.480275986321], "value": 6110.508449674295, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 121.0, 119.0, 120.0, 120.0, 119.0, 119.0, 120.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 134.0, 138.0, 167.0, 134.0, 130.0, 132.0, 131.0, 151.0, 131.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 177.0, 164.0, 163.0, 164.0, 162.0, 163.0, 164.0, 164.0, 166.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 111.0, 78.0, 77.0, 76.0, 77.0, 94.0, 78.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 100.0, 84.0, 84.0, 84.0, 98.0, 83.0, 84.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 120.0, 118.0, 118.0, 120.0, 119.0, 119.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 149.0, 150.0, 149.0, 150.0, 148.0, 150.0, 150.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 69.0, 65.0, 64.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 69.0, 66.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 89.0, 86.0, 86.0, 91.0, 86.0, 86.0, 88.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 161.0, 158.0, 151.0, 149.0, 155.0, 148.0, 146.0, 248.0, 148.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 190.0, 181.0, 179.0, 185.0, 189.0, 186.0, 183.0, 180.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 82.0, 75.0, 73.0, 73.0, 72.0, 71.0, 72.0, 89.0], "value": 75.5, "unit": "score"}]}]} 12:53:19 INFO - Return code: 0 12:53:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:53:19 ERROR - # TBPL SUCCESS # 12:53:19 INFO - Running post-action listener: _resource_record_post_action 12:53:19 INFO - [mozharness: 2016-12-02 20:53:19.353027Z] Finished run-tests step (success) 12:53:19 INFO - Running post-run listener: _resource_record_post_run 12:53:19 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390868992; Read time: 52; Write time: 305124 12:53:19 INFO - TinderboxPrint: CPU usage
13.5% 12:53:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 52 12:53:19 INFO - TinderboxPrint: I/O write bytes / time
390,868,992 / 305,124 12:53:19 INFO - TinderboxPrint: CPU idle
8,291.1 (86.5%) 12:53:19 INFO - TinderboxPrint: CPU user
1,231.3 (12.8%) 12:53:19 INFO - TinderboxPrint: Swap in / out
0 / 0 12:53:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99241984; Read time: 0; Write time: 105392 12:53:19 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290721792; Read time: 40; Write time: 199708 12:53:20 INFO - Running post-run listener: _upload_blobber_files 12:53:20 INFO - Blob upload gear active. 12:53:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:53:20 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:53:20 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:53:20 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:53:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:21 INFO - (blobuploader) - INFO - Done attempting. 12:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:22 INFO - (blobuploader) - INFO - Done attempting. 12:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:26 INFO - (blobuploader) - INFO - Done attempting. 12:53:26 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:26 INFO - Return code: 0 12:53:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1cbe93ca0ae7de8da07c0cce176321b64c55f1c118decd2e52242d6efd81832a08eac36098fa1e4f506405d47b2a353cefb91fa6a0672f1e01a2c67bf432ac70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6cb0108c4d995eafe8c5e0f6653845e6a99107bdbe902fb9b12059c5cdb195dadf73a0298851710d8af05850972df9cc7112adc358134a4cb04f9fbc81eb0fa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8a28b49083d871252778f65d7425d7b239b59ad21d79ee164b7ea0244f95efe3b4a55ccba6669b5846249602adf9526dddd0392b78f7a911d9277bb3cbcd7659"} 12:53:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:26 INFO - Contents: 12:53:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1cbe93ca0ae7de8da07c0cce176321b64c55f1c118decd2e52242d6efd81832a08eac36098fa1e4f506405d47b2a353cefb91fa6a0672f1e01a2c67bf432ac70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6cb0108c4d995eafe8c5e0f6653845e6a99107bdbe902fb9b12059c5cdb195dadf73a0298851710d8af05850972df9cc7112adc358134a4cb04f9fbc81eb0fa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8a28b49083d871252778f65d7425d7b239b59ad21d79ee164b7ea0244f95efe3b4a55ccba6669b5846249602adf9526dddd0392b78f7a911d9277bb3cbcd7659"} 12:53:26 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:26 INFO - Copying logs to upload dir... 12:53:26 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.879873 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-02 12:53:25.557116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 12:53:25.560556) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1cbe93ca0ae7de8da07c0cce176321b64c55f1c118decd2e52242d6efd81832a08eac36098fa1e4f506405d47b2a353cefb91fa6a0672f1e01a2c67bf432ac70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6cb0108c4d995eafe8c5e0f6653845e6a99107bdbe902fb9b12059c5cdb195dadf73a0298851710d8af05850972df9cc7112adc358134a4cb04f9fbc81eb0fa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8a28b49083d871252778f65d7425d7b239b59ad21d79ee164b7ea0244f95efe3b4a55ccba6669b5846249602adf9526dddd0392b78f7a911d9277bb3cbcd7659"} build_url:https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011802 build_url: 'https://queue.taskcluster.net/v1/task/YMt8cdmTQ6aUHBQwFogxHw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1cbe93ca0ae7de8da07c0cce176321b64c55f1c118decd2e52242d6efd81832a08eac36098fa1e4f506405d47b2a353cefb91fa6a0672f1e01a2c67bf432ac70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/6cb0108c4d995eafe8c5e0f6653845e6a99107bdbe902fb9b12059c5cdb195dadf73a0298851710d8af05850972df9cc7112adc358134a4cb04f9fbc81eb0fa8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8a28b49083d871252778f65d7425d7b239b59ad21d79ee164b7ea0244f95efe3b4a55ccba6669b5846249602adf9526dddd0392b78f7a911d9277bb3cbcd7659"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 12:53:25.586598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:53:25.586975) ========= 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=c6927cf182745ad25b1d38b9000001fe-1480710758.595675-1189083004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 12:53:25.670208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 12:53:25.670519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 12:53:25.670820) ========= ========= Total master_lag: 0.16 =========